builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1450453356.17 results: success (0) buildid: 20151218062559 builduid: f28b054323b04a6399dddc95523d778b revision: c5cb194cc9cb56d742fb3a7a826f0080b0404edc ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.170216) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.170741) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.171033) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006354 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.203994) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.204306) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.448523) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.448903) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.498142) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.498494) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.498924) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.499206) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-18 07:42:37-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 44.0M=0s 2015-12-18 07:42:37 (44.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.185083 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.697685) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.698031) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017163 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.747271) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:36.747611) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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 c5cb194cc9cb56d742fb3a7a826f0080b0404edc --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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-18 07:42:37,641 truncating revision to first 12 chars 2015-12-18 07:42:37,641 Setting DEBUG logging. 2015-12-18 07:42:37,641 attempt 1/10 2015-12-18 07:42:37,641 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/c5cb194cc9cb?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-18 07:42:37,871 unpacking tar archive at: mozilla-central-c5cb194cc9cb/testing/mozharness/ program finished with exit code 0 elapsedTime=0.499504 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:37.260843) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:37.261145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:37.269880) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:37.270146) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-18 07:42:37.270565) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-18 07:42:37.270854) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --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', '--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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 07:42:38 INFO - MultiFileLogger online at 20151218 07:42:38 in /builds/slave/test 07:42:38 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --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 07:42:38 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:42:38 INFO - {'append_to_log': False, 07:42:38 INFO - 'base_work_dir': '/builds/slave/test', 07:42:38 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 07:42:38 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:42:38 INFO - 'branch': 'Firefox-Non-PGO', 07:42:38 INFO - 'buildbot_json_path': 'buildprops.json', 07:42:38 INFO - 'config_files': ('talos/linux_config.py',), 07:42:38 INFO - 'default_actions': ('clobber', 07:42:38 INFO - 'read-buildbot-config', 07:42:38 INFO - 'download-and-extract', 07:42:38 INFO - 'populate-webroot', 07:42:38 INFO - 'create-virtualenv', 07:42:38 INFO - 'install', 07:42:38 INFO - 'run-tests'), 07:42:38 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:42:38 INFO - 'download_minidump_stackwalk': True, 07:42:38 INFO - 'download_symbols': 'ondemand', 07:42:38 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:42:38 INFO - 'tooltool.py': '/tools/tooltool.py', 07:42:38 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:42:38 INFO - '/tools/misc-python/virtualenv.py')}, 07:42:38 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:42:38 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:42:38 INFO - 'installer_path': 'installer.exe', 07:42:38 INFO - 'log_level': 'info', 07:42:38 INFO - 'log_name': 'talos', 07:42:38 INFO - 'log_to_console': True, 07:42:38 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 07:42:38 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 07:42:38 INFO - 'opt_config_files': (), 07:42:38 INFO - 'pip_index': False, 07:42:38 INFO - 'sps_profile': False, 07:42:38 INFO - 'sps_profile_interval': 0, 07:42:38 INFO - 'suite': 'dromaeojs', 07:42:38 INFO - 'system_bits': '64', 07:42:38 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:42:38 INFO - 'title': 'talos-linux64-ix-039', 07:42:38 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:42:38 INFO - 'use_talos_json': True, 07:42:38 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:42:38 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:42:38 INFO - 'work_dir': 'build'} 07:42:38 INFO - ##### 07:42:38 INFO - ##### Running clobber step. 07:42:38 INFO - ##### 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: clobber 07:42:38 INFO - rmtree: /builds/slave/test/build 07:42:38 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - ##### 07:42:38 INFO - ##### Running read-buildbot-config step. 07:42:38 INFO - ##### 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: read_buildbot_config 07:42:38 INFO - Using buildbot properties: 07:42:38 INFO - { 07:42:38 INFO - "project": "", 07:42:38 INFO - "product": "firefox", 07:42:38 INFO - "script_repo_revision": "production", 07:42:38 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 07:42:38 INFO - "repository": "", 07:42:38 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 07:42:38 INFO - "buildid": "20151218062559", 07:42:38 INFO - "pgo_build": "False", 07:42:38 INFO - "basedir": "/builds/slave/test", 07:42:38 INFO - "buildnumber": 245, 07:42:38 INFO - "slavename": "talos-linux64-ix-039", 07:42:38 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 07:42:38 INFO - "platform": "ubuntu64_hw", 07:42:38 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 07:42:38 INFO - "branch": "mozilla-central", 07:42:38 INFO - "repo_path": "mozilla-central", 07:42:38 INFO - "revision": "c5cb194cc9cb56d742fb3a7a826f0080b0404edc", 07:42:38 INFO - "stage_platform": "linux64", 07:42:38 INFO - "builduid": "f28b054323b04a6399dddc95523d778b", 07:42:38 INFO - "slavebuilddir": "test" 07:42:38 INFO - } 07:42:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 07:42:38 INFO - Running post-action listener: _resource_record_post_action 07:42:38 INFO - ##### 07:42:38 INFO - ##### Running download-and-extract step. 07:42:38 INFO - ##### 07:42:38 INFO - Running pre-action listener: _resource_record_pre_action 07:42:38 INFO - Running main action method: download_and_extract 07:42:38 INFO - mkdir: /builds/slave/test/build/tests 07:42:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:38 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 07:42:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json 07:42:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json 07:42:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 07:42:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 07:42:39 INFO - Downloaded 1302 bytes. 07:42:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 07:42:39 INFO - Using the following test package requirements: 07:42:39 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:42:39 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 07:42:39 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'jsshell-linux-x86_64.zip'], 07:42:39 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 07:42:39 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:42:39 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 07:42:39 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 07:42:39 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 07:42:39 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 07:42:39 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 07:42:39 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 07:42:39 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 07:42: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')]} 07:42:39 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:41 INFO - Downloaded 21871955 bytes. 07:42: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 07:42:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42: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 07:42:42 INFO - Return code: 0 07:42:42 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 07:42: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')]} 07:42:42 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 07:42:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:43 INFO - Downloaded 21871955 bytes. 07:42:43 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 07:42:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 07:42:43 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 07:42:45 INFO - Return code: 0 07:42:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:45 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 07:42:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:42:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:42:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:46 INFO - Downloaded 11132039 bytes. 07:42:46 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 07:42:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 07:42:46 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 07:42:46 INFO - Return code: 0 07:42:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:46 INFO - https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 07:42:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:42:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:42:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hd4L16v3RlWmfPt5WSVAqA/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 07:42:51 INFO - Downloaded 53017186 bytes. 07:42:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:42:51 INFO - mkdir: /builds/slave/test/properties 07:42:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:42:51 INFO - Writing to file /builds/slave/test/properties/build_url 07:42:51 INFO - Contents: 07:42:51 INFO - build_url:https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 07:42:51 INFO - Running post-action listener: _resource_record_post_action 07:42:51 INFO - Running post-action listener: set_extra_try_arguments 07:42:51 INFO - ##### 07:42:51 INFO - ##### Running populate-webroot step. 07:42:51 INFO - ##### 07:42:51 INFO - Running pre-action listener: _resource_record_pre_action 07:42:51 INFO - Running main action method: populate_webroot 07:42:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:42:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:42:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:42:51 INFO - '--tppagecycles', 07:42:51 INFO - '7'], 07:42:51 INFO - 'tests': ['tsvgm']}}, 07:42:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 07:42:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:42:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:42:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 07:42:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:42:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'tests': ['damp', 'tps']}, 07:42:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['damp', 'tps']}, 07:42:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 07:42:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:42:51 INFO - 'other': {'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'other_l64': {'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'other_nol64': {'tests': ['a11yr', 07:42:51 INFO - 'ts_paint', 07:42:51 INFO - 'tpaint', 07:42:51 INFO - 'sessionrestore', 07:42:51 INFO - 'sessionrestore_no_auto_restore']}, 07:42:51 INFO - 'svgr': {'tests': ['tsvgx', 07:42:51 INFO - 'tsvgr_opacity', 07:42:51 INFO - 'tart', 07:42:51 INFO - 'tscrollx', 07:42:51 INFO - 'cart']}, 07:42:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['tsvgx', 07:42:51 INFO - 'tsvgr_opacity', 07:42:51 INFO - 'tart', 07:42:51 INFO - 'tscrollx', 07:42:51 INFO - 'cart']}, 07:42:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'tests': ['tp5o']}, 07:42:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'talos_options': ['--e10s'], 07:42:51 INFO - 'tests': ['tp5o']}, 07:42:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'talos_options': ['--xperf_path', 07:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:51 INFO - 'tests': ['tp5n']}, 07:42:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 07:42:51 INFO - 'talos_options': ['--e10s', 07:42:51 INFO - '--xperf_path', 07:42:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:42:51 INFO - 'tests': ['tp5n']}}, 07:42:51 INFO - 'talos.zip': {'path': '', 07:42:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:42:51 INFO - Running post-action listener: _resource_record_post_action 07:42:51 INFO - ##### 07:42:51 INFO - ##### Running create-virtualenv step. 07:42:51 INFO - ##### 07:42:51 INFO - Running pre-action listener: _resource_record_pre_action 07:42:51 INFO - Running main action method: create_virtualenv 07:42:51 INFO - Creating virtualenv /builds/slave/test/build/venv 07:42:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 07:42:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:42:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:42:51 INFO - Using real prefix '/usr' 07:42:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:42:51 INFO - Installing distribute.............................................................................................................................................................................................done. 07:42:53 INFO - Installing pip.................done. 07:42:53 INFO - Return code: 0 07:42:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:53 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:53 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 07:42:53 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 07:42:53 INFO - Using env: {'DISPLAY': ':0', 07:42:53 INFO - 'HOME': '/home/cltbld', 07:42:53 INFO - 'LANG': 'en_US.UTF-8', 07:42:53 INFO - 'LANGUAGE': 'en_US:en', 07:42:53 INFO - 'LOGNAME': 'cltbld', 07:42:53 INFO - 'MAIL': '/var/mail/cltbld', 07:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:53 INFO - 'MOZ_NO_REMOTE': '1', 07:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:53 INFO - 'NO_EM_RESTART': '1', 07:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:53 INFO - 'PWD': '/builds/slave/test', 07:42:53 INFO - 'SHELL': '/bin/bash', 07:42:53 INFO - 'SHLVL': '1', 07:42:53 INFO - 'TERM': 'linux', 07:42:53 INFO - 'TMOUT': '86400', 07:42:53 INFO - 'USER': 'cltbld', 07:42:53 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:53 INFO - '_': '/tools/buildbot/bin/python'} 07:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 07:42:53 INFO - Cleaning up... 07:42:53 INFO - Return code: 0 07:42:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 07:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:53 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:53 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 07:42:53 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 07:42:53 INFO - Using env: {'DISPLAY': ':0', 07:42:53 INFO - 'HOME': '/home/cltbld', 07:42:53 INFO - 'LANG': 'en_US.UTF-8', 07:42:53 INFO - 'LANGUAGE': 'en_US:en', 07:42:53 INFO - 'LOGNAME': 'cltbld', 07:42:53 INFO - 'MAIL': '/var/mail/cltbld', 07:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:53 INFO - 'MOZ_NO_REMOTE': '1', 07:42:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:53 INFO - 'NO_EM_RESTART': '1', 07:42:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:53 INFO - 'PWD': '/builds/slave/test', 07:42:53 INFO - 'SHELL': '/bin/bash', 07:42:53 INFO - 'SHLVL': '1', 07:42:53 INFO - 'TERM': 'linux', 07:42:53 INFO - 'TMOUT': '86400', 07:42:53 INFO - 'USER': 'cltbld', 07:42:53 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:53 INFO - '_': '/tools/buildbot/bin/python'} 07:42:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:54 INFO - Downloading/unpacking psutil>=0.7.1 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42: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 07:42:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 07:42:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 07:42:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:42:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:55 INFO - Installing collected packages: psutil 07:42:55 INFO - Running setup.py install for psutil 07:42:55 INFO - building 'psutil._psutil_linux' extension 07:42:55 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 07:42:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 07:42:56 INFO - building 'psutil._psutil_posix' extension 07:42:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 07:42:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 07:42:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:42:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:42:56 INFO - Successfully installed psutil 07:42:56 INFO - Cleaning up... 07:42:56 INFO - Return code: 0 07:42:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42:56 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:56 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 07:42:56 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 07:42:56 INFO - Using env: {'DISPLAY': ':0', 07:42:56 INFO - 'HOME': '/home/cltbld', 07:42:56 INFO - 'LANG': 'en_US.UTF-8', 07:42:56 INFO - 'LANGUAGE': 'en_US:en', 07:42:56 INFO - 'LOGNAME': 'cltbld', 07:42:56 INFO - 'MAIL': '/var/mail/cltbld', 07:42:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:56 INFO - 'MOZ_NO_REMOTE': '1', 07:42:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:56 INFO - 'NO_EM_RESTART': '1', 07:42:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:56 INFO - 'PWD': '/builds/slave/test', 07:42:56 INFO - 'SHELL': '/bin/bash', 07:42:56 INFO - 'SHLVL': '1', 07:42:56 INFO - 'TERM': 'linux', 07:42:56 INFO - 'TMOUT': '86400', 07:42:56 INFO - 'USER': 'cltbld', 07:42:56 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:42:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:56 INFO - '_': '/tools/buildbot/bin/python'} 07:42:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 07:42:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 07:42:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:42:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 07:42:58 INFO - Installing collected packages: mozsystemmonitor 07:42:58 INFO - Running setup.py install for mozsystemmonitor 07:42:58 INFO - Successfully installed mozsystemmonitor 07:42:58 INFO - Cleaning up... 07:42:58 INFO - Return code: 0 07:42:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:42: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')]} 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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')]} 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:42:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:42: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', '--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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:42:58 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 07:42:58 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 07:42:58 INFO - Using env: {'DISPLAY': ':0', 07:42:58 INFO - 'HOME': '/home/cltbld', 07:42:58 INFO - 'LANG': 'en_US.UTF-8', 07:42:58 INFO - 'LANGUAGE': 'en_US:en', 07:42:58 INFO - 'LOGNAME': 'cltbld', 07:42:58 INFO - 'MAIL': '/var/mail/cltbld', 07:42:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:42:58 INFO - 'MOZ_NO_REMOTE': '1', 07:42:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:42:58 INFO - 'NO_EM_RESTART': '1', 07:42:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:42:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:42:58 INFO - 'PWD': '/builds/slave/test', 07:42:58 INFO - 'SHELL': '/bin/bash', 07:42:58 INFO - 'SHLVL': '1', 07:42:58 INFO - 'TERM': 'linux', 07:42:58 INFO - 'TMOUT': '86400', 07:42:58 INFO - 'USER': 'cltbld', 07:42:58 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:42:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:42:58 INFO - '_': '/tools/buildbot/bin/python'} 07:42:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:42:58 INFO - Downloading/unpacking blobuploader==1.2.4 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:42:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:42:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:00 INFO - Downloading blobuploader-1.2.4.tar.gz 07:43:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 07:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:43:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 07:43:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:43:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:01 INFO - Downloading docopt-0.6.1.tar.gz 07:43:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 07:43:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:43:01 INFO - Installing collected packages: blobuploader, requests, docopt 07:43:01 INFO - Running setup.py install for blobuploader 07:43:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:43:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:43:01 INFO - Running setup.py install for requests 07:43:01 INFO - Running setup.py install for docopt 07:43:01 INFO - Successfully installed blobuploader requests docopt 07:43:01 INFO - Cleaning up... 07:43:01 INFO - Return code: 0 07:43:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:01 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:43:01 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 07:43:01 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 07:43:01 INFO - Using env: {'DISPLAY': ':0', 07:43:01 INFO - 'HOME': '/home/cltbld', 07:43:01 INFO - 'LANG': 'en_US.UTF-8', 07:43:01 INFO - 'LANGUAGE': 'en_US:en', 07:43:01 INFO - 'LOGNAME': 'cltbld', 07:43:01 INFO - 'MAIL': '/var/mail/cltbld', 07:43:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:01 INFO - 'MOZ_NO_REMOTE': '1', 07:43:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:01 INFO - 'NO_EM_RESTART': '1', 07:43:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:01 INFO - 'PWD': '/builds/slave/test', 07:43:01 INFO - 'SHELL': '/bin/bash', 07:43:01 INFO - 'SHLVL': '1', 07:43:01 INFO - 'TERM': 'linux', 07:43:01 INFO - 'TMOUT': '86400', 07:43:01 INFO - 'USER': 'cltbld', 07:43:01 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:01 INFO - '_': '/tools/buildbot/bin/python'} 07:43:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:01 INFO - Running setup.py (path:/tmp/pip-SmgyIs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:01 INFO - Running setup.py (path:/tmp/pip-xu7gEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:02 INFO - Running setup.py (path:/tmp/pip-cf26gQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:02 INFO - Running setup.py (path:/tmp/pip-91Zcl4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:02 INFO - Running setup.py (path:/tmp/pip-D93k5a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:02 INFO - Running setup.py (path:/tmp/pip-oUM9ml-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:02 INFO - Running setup.py (path:/tmp/pip-l3dBXv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:02 INFO - Running setup.py (path:/tmp/pip-egE168-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:02 INFO - Running setup.py (path:/tmp/pip-bn_1iz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:02 INFO - Running setup.py (path:/tmp/pip-mjY8LD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:02 INFO - Running setup.py (path:/tmp/pip-0SlxIj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:02 INFO - Running setup.py (path:/tmp/pip-wDy34p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:02 INFO - Running setup.py (path:/tmp/pip-pFIYGD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:02 INFO - Running setup.py (path:/tmp/pip-8Bsp7V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:02 INFO - Running setup.py (path:/tmp/pip-xIrph4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:02 INFO - Running setup.py (path:/tmp/pip-z5NbuZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:03 INFO - Running setup.py (path:/tmp/pip-YCv59D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:43:03 INFO - Running setup.py install for manifestparser 07:43:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozcrash 07:43:03 INFO - Running setup.py install for mozdebug 07:43:03 INFO - Running setup.py install for mozdevice 07:43:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozfile 07:43:03 INFO - Running setup.py install for mozhttpd 07:43:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozinfo 07:43:03 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozInstall 07:43:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:43:03 INFO - Running setup.py install for mozleak 07:43:04 INFO - Running setup.py install for mozlog 07:43:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for moznetwork 07:43:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozprocess 07:43:04 INFO - Running setup.py install for mozprofile 07:43:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozrunner 07:43:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Running setup.py install for mozscreenshot 07:43:04 INFO - Running setup.py install for moztest 07:43:04 INFO - Running setup.py install for mozversion 07:43:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:43:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:43:04 INFO - Cleaning up... 07:43:04 INFO - Return code: 0 07:43:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:43:04 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 07:43:04 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 07:43:04 INFO - Using env: {'DISPLAY': ':0', 07:43:04 INFO - 'HOME': '/home/cltbld', 07:43:04 INFO - 'LANG': 'en_US.UTF-8', 07:43:04 INFO - 'LANGUAGE': 'en_US:en', 07:43:04 INFO - 'LOGNAME': 'cltbld', 07:43:04 INFO - 'MAIL': '/var/mail/cltbld', 07:43:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:04 INFO - 'MOZ_NO_REMOTE': '1', 07:43:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:04 INFO - 'NO_EM_RESTART': '1', 07:43:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:04 INFO - 'PWD': '/builds/slave/test', 07:43:04 INFO - 'SHELL': '/bin/bash', 07:43:04 INFO - 'SHLVL': '1', 07:43:04 INFO - 'TERM': 'linux', 07:43:04 INFO - 'TMOUT': '86400', 07:43:04 INFO - 'USER': 'cltbld', 07:43:04 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:04 INFO - '_': '/tools/buildbot/bin/python'} 07:43:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:43:05 INFO - Running setup.py (path:/tmp/pip-PDIHvE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:43:05 INFO - Running setup.py (path:/tmp/pip-jaac8t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:43:05 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)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:43:05 INFO - Running setup.py (path:/tmp/pip-atBYOf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:43:05 INFO - Running setup.py (path:/tmp/pip-tugvfn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:43:05 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)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:43:05 INFO - Running setup.py (path:/tmp/pip-qFvgzA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:43:05 INFO - Running setup.py (path:/tmp/pip-Dme9Ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:43:05 INFO - Running setup.py (path:/tmp/pip-jleXpG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:43:05 INFO - Running setup.py (path:/tmp/pip-_IWrbB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:43:05 INFO - Running setup.py (path:/tmp/pip-bjA_CN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:43:05 INFO - Running setup.py (path:/tmp/pip-4IZ7aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:43:05 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)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:43:05 INFO - Running setup.py (path:/tmp/pip-FuwSIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:43:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:43:05 INFO - Running setup.py (path:/tmp/pip-tj8M_e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:43:05 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)) 07:43:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:43:05 INFO - Running setup.py (path:/tmp/pip-byMh1N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:43:06 INFO - Running setup.py (path:/tmp/pip-6HDN3E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:43:06 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)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:06 INFO - Running setup.py (path:/tmp/pip-oY__lS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:43:06 INFO - Running setup.py (path:/tmp/pip-YK1jif-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 07:43:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:43:06 INFO - Running setup.py (path:/tmp/pip-wnHwcW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 07:43:06 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)) 07:43:06 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)) 07:43:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 07:43:06 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)) 07:43:06 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)) 07:43:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43: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 07:43:08 INFO - Downloading blessings-1.5.1.tar.gz 07:43:08 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 07:43:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:43:08 INFO - Installing collected packages: blessings 07:43:08 INFO - Running setup.py install for blessings 07:43:08 INFO - Successfully installed blessings 07:43:08 INFO - Cleaning up... 07:43:08 INFO - Return code: 0 07:43:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:43:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:08 INFO - Reading from file tmpfile_stdout 07:43:08 INFO - Current package versions: 07:43:08 INFO - argparse == 1.2.1 07:43:08 INFO - blessings == 1.5.1 07:43:08 INFO - blobuploader == 1.2.4 07:43:08 INFO - docopt == 0.6.1 07:43:08 INFO - manifestparser == 1.1 07:43:08 INFO - mozInstall == 1.12 07:43:08 INFO - mozcrash == 0.16 07:43:08 INFO - mozdebug == 0.1 07:43:08 INFO - mozdevice == 0.47 07:43:08 INFO - mozfile == 1.2 07:43:08 INFO - mozhttpd == 0.7 07:43:08 INFO - mozinfo == 0.9 07:43:08 INFO - mozleak == 0.1 07:43:08 INFO - mozlog == 3.1 07:43:08 INFO - moznetwork == 0.27 07:43:08 INFO - mozprocess == 0.22 07:43:08 INFO - mozprofile == 0.27 07:43:08 INFO - mozrunner == 6.11 07:43:08 INFO - mozscreenshot == 0.1 07:43:08 INFO - mozsystemmonitor == 0.0 07:43:08 INFO - moztest == 0.7 07:43:08 INFO - mozversion == 1.4 07:43:08 INFO - psutil == 3.1.1 07:43:08 INFO - requests == 1.2.3 07:43:08 INFO - wsgiref == 0.1.2 07:43:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:43:08 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 07:43:08 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 07:43:08 INFO - Using env: {'DISPLAY': ':0', 07:43:08 INFO - 'HOME': '/home/cltbld', 07:43:08 INFO - 'LANG': 'en_US.UTF-8', 07:43:08 INFO - 'LANGUAGE': 'en_US:en', 07:43:08 INFO - 'LOGNAME': 'cltbld', 07:43:08 INFO - 'MAIL': '/var/mail/cltbld', 07:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:08 INFO - 'MOZ_NO_REMOTE': '1', 07:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:08 INFO - 'NO_EM_RESTART': '1', 07:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:08 INFO - 'PWD': '/builds/slave/test', 07:43:08 INFO - 'SHELL': '/bin/bash', 07:43:08 INFO - 'SHLVL': '1', 07:43:08 INFO - 'TERM': 'linux', 07:43:08 INFO - 'TMOUT': '86400', 07:43:08 INFO - 'USER': 'cltbld', 07:43:08 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:08 INFO - '_': '/tools/buildbot/bin/python'} 07:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 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)) 07:43:08 INFO - Cleaning up... 07:43:08 INFO - Return code: 0 07:43:08 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:08 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:43:08 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 07:43:08 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 07:43:08 INFO - Using env: {'DISPLAY': ':0', 07:43:08 INFO - 'HOME': '/home/cltbld', 07:43:08 INFO - 'LANG': 'en_US.UTF-8', 07:43:08 INFO - 'LANGUAGE': 'en_US:en', 07:43:08 INFO - 'LOGNAME': 'cltbld', 07:43:08 INFO - 'MAIL': '/var/mail/cltbld', 07:43:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:08 INFO - 'MOZ_NO_REMOTE': '1', 07:43:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:08 INFO - 'NO_EM_RESTART': '1', 07:43:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:08 INFO - 'PWD': '/builds/slave/test', 07:43:08 INFO - 'SHELL': '/bin/bash', 07:43:08 INFO - 'SHLVL': '1', 07:43:08 INFO - 'TERM': 'linux', 07:43:08 INFO - 'TMOUT': '86400', 07:43:08 INFO - 'USER': 'cltbld', 07:43:08 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:08 INFO - '_': '/tools/buildbot/bin/python'} 07:43:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:08 INFO - Downloading/unpacking jsonschema 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:10 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:43:10 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 07:43:10 INFO - Downloading/unpacking functools32 (from jsonschema) 07:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:10 INFO - Downloading functools32-3.2.3-2.tar.gz 07:43:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 07:43:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:43:10 INFO - warning: no files found matching '*.txt' 07:43:10 INFO - no previously-included directories found matching 'build' 07:43:10 INFO - no previously-included directories found matching 'dist' 07:43:10 INFO - no previously-included directories found matching '.git*' 07:43:10 INFO - Installing collected packages: jsonschema, functools32 07:43:11 INFO - Running setup.py install for functools32 07:43:11 INFO - warning: no files found matching '*.txt' 07:43:11 INFO - no previously-included directories found matching 'build' 07:43:11 INFO - no previously-included directories found matching 'dist' 07:43:11 INFO - no previously-included directories found matching '.git*' 07:43:11 INFO - Successfully installed jsonschema functools32 07:43:11 INFO - Cleaning up... 07:43:11 INFO - Return code: 0 07:43:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 07:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:43:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:43:11 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 0x7fd475f1ef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23898a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2457240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, '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': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 07:43:11 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 07:43:11 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 07:43:11 INFO - Using env: {'DISPLAY': ':0', 07:43:11 INFO - 'HOME': '/home/cltbld', 07:43:11 INFO - 'LANG': 'en_US.UTF-8', 07:43:11 INFO - 'LANGUAGE': 'en_US:en', 07:43:11 INFO - 'LOGNAME': 'cltbld', 07:43:11 INFO - 'MAIL': '/var/mail/cltbld', 07:43:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:11 INFO - 'MOZ_NO_REMOTE': '1', 07:43:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:11 INFO - 'NO_EM_RESTART': '1', 07:43:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:11 INFO - 'PWD': '/builds/slave/test', 07:43:11 INFO - 'SHELL': '/bin/bash', 07:43:11 INFO - 'SHLVL': '1', 07:43:11 INFO - 'TERM': 'linux', 07:43:11 INFO - 'TMOUT': '86400', 07:43:11 INFO - 'USER': 'cltbld', 07:43:11 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:11 INFO - '_': '/tools/buildbot/bin/python'} 07:43:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:43:11 INFO - Downloading/unpacking flake8 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 07:43:13 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 07:43:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 07:43:13 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 07:43:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 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 07:43:13 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:43:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:43:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:43:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 07:43:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 07:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:13 INFO - no previously-included directories found matching 'docs/_build' 07:43:13 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 07:43:13 INFO - Running setup.py install for pep8 07:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 07:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 07:43:13 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 07:43:13 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 07:43:13 INFO - no previously-included directories found matching 'docs/_build' 07:43:13 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 07:43:13 INFO - Successfully installed flake8 mccabe pyflakes pep8 07:43:13 INFO - Cleaning up... 07:43:13 INFO - Return code: 0 07:43:13 INFO - Running post-action listener: _resource_record_post_action 07:43:13 INFO - Running post-action listener: _start_resource_monitoring 07:43:13 INFO - Starting resource monitoring. 07:43:13 INFO - ##### 07:43:13 INFO - ##### Running install step. 07:43:13 INFO - ##### 07:43:13 INFO - Running pre-action listener: _resource_record_pre_action 07:43:13 INFO - Running main action method: install 07:43:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:43:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:43:14 INFO - Reading from file tmpfile_stdout 07:43:14 INFO - Detecting whether we're running mozinstall >=1.0... 07:43:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:43:14 INFO - Reading from file tmpfile_stdout 07:43:14 INFO - Output received: 07:43:14 INFO - Usage: mozinstall [options] installer 07:43:14 INFO - Options: 07:43:14 INFO - -h, --help show this help message and exit 07:43:14 INFO - -d DEST, --destination=DEST 07:43:14 INFO - Directory to install application into. [default: 07:43:14 INFO - "/builds/slave/test"] 07:43:14 INFO - --app=APP Application being installed. [default: firefox] 07:43:14 INFO - mkdir: /builds/slave/test/build/application 07:43:14 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'] 07:43:14 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 07:43:29 INFO - Reading from file tmpfile_stdout 07:43:29 INFO - Output received: 07:43:29 INFO - /builds/slave/test/build/application/firefox/firefox 07:43:29 INFO - Running post-action listener: _resource_record_post_action 07:43:29 INFO - ##### 07:43:29 INFO - ##### Running run-tests step. 07:43:29 INFO - ##### 07:43:29 INFO - Running pre-action listener: _resource_record_pre_action 07:43:29 INFO - Running main action method: run_tests 07:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:43:29 INFO - Python 2.7.3 07:43:29 INFO - Return code: 0 07:43:29 INFO - grabbing minidump binary from tooltool 07:43:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 07:43:29 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 0x24e60b0>, '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 0x24e6fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x24e7440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:43:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 07:43:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 07:43:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:43:29 INFO - Return code: 0 07:43:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 07:43:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:43:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:43:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 07:43:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:43:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 07:43:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 07:43:30 INFO - Return code: 0 07:43:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 07:43:30 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 --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 07:43:30 INFO - Using env: {'DISPLAY': ':0', 07:43:30 INFO - 'HOME': '/home/cltbld', 07:43:30 INFO - 'LANG': 'en_US.UTF-8', 07:43:30 INFO - 'LANGUAGE': 'en_US:en', 07:43:30 INFO - 'LOGNAME': 'cltbld', 07:43:30 INFO - 'MAIL': '/var/mail/cltbld', 07:43:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:43:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 07:43:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:43:30 INFO - 'MOZ_NO_REMOTE': '1', 07:43:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:43:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 07:43:30 INFO - 'NO_EM_RESTART': '1', 07:43:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 07:43:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:43:30 INFO - 'PWD': '/builds/slave/test', 07:43:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:43:30 INFO - 'SHELL': '/bin/bash', 07:43:30 INFO - 'SHLVL': '1', 07:43:30 INFO - 'TERM': 'linux', 07:43:30 INFO - 'TMOUT': '86400', 07:43:30 INFO - 'USER': 'cltbld', 07:43:30 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1450452864.996723-1105665772', 07:43:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:43:30 INFO - '_': '/tools/buildbot/bin/python'} 07:43:30 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', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 07:43:30 INFO - mozversion INFO | application_buildid: 20151218062559 07:43:30 INFO - mozversion INFO | application_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 07:43:30 INFO - mozversion INFO | application_display_name: Nightly 07:43:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:43:30 INFO - mozversion INFO | application_name: Firefox 07:43:30 INFO - mozversion INFO | application_remotingname: firefox 07:43:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 07:43:30 INFO - mozversion INFO | application_vendor: Mozilla 07:43:30 INFO - mozversion INFO | application_version: 46.0a1 07:43:30 INFO - mozversion INFO | platform_buildid: 20151218062559 07:43:30 INFO - mozversion INFO | platform_changeset: c5cb194cc9cb56d742fb3a7a826f0080b0404edc 07:43:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 07:43:30 INFO - mozversion INFO | platform_version: 46.0a1 07:43:30 INFO - 2015-12-18 07:43:30,956 DEBUG : using testdate: 1450453410 07:43:30 INFO - 2015-12-18 07:43:30,956 DEBUG : actual date: 1450453410 07:43:31 INFO - 2015-12-18 07:43:31,005 INFO : starting webserver on 'localhost:41477' 07:43:31 INFO - 2015-12-18 07:43:31,006 INFO : Starting test suite talos-linux64-ix-039 07:43:31 INFO - 2015-12-18 07:43:31,006 INFO : Starting test dromaeo_css 07:43:31 INFO - 2015-12-18 07:43:31,006 DEBUG : operating with platform_type : linux_ 07:43:31 INFO - 2015-12-18 07:43:31,007 INFO : Initialising browser for dromaeo_css test... 07:43:31 INFO - 2015-12-18 07:43:31,023 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkrXSG/profile http://localhost:41477/getInfo.html 07:43:35 INFO - 2015-12-18 07:43:35,481 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 07:43:35 INFO - 2015-12-18 07:43:35,482 DEBUG : BROWSER_OUTPUT: colorDepth:24 07:43:35 INFO - 2015-12-18 07:43:35,482 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 07:43:35 INFO - 2015-12-18 07:43:35,482 DEBUG : BROWSER_OUTPUT: __metrics 07:43:35 INFO - 2015-12-18 07:43:35,563 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] 07:43:35 INFO - 2015-12-18 07:43:35,619 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:43:35 INFO - 2015-12-18 07:43:35,904 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 07:43:36 INFO - 2015-12-18 07:43:36,544 INFO : Browser initialized. 07:43:36 INFO - 2015-12-18 07:43:36,544 INFO : Running cycle 1/1 for dromaeo_css test... 07:43:36 INFO - 2015-12-18 07:43:36,545 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMkrXSG/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 07:43:48 INFO - 2015-12-18 07:43:48,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 148267008 07:43:48 INFO - 2015-12-18 07:43:48,527 DEBUG : BROWSER_OUTPUT: 07:44:40 INFO - 2015-12-18 07:44:40,035 DEBUG : BROWSER_OUTPUT: 1450453480031 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 07:46:52 INFO - 2015-12-18 07:46:52,122 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41477/tests/dromaeo/cssquery-ext.html) 07:46:53 INFO - 2015-12-18 07:46:53,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 245420032 07:46:53 INFO - 2015-12-18 07:46:53,167 DEBUG : BROWSER_OUTPUT: 07:49:55 INFO - 2015-12-18 07:49:55,705 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-ext.html (next: http://localhost:41477/tests/dromaeo/cssquery-jquery.html) 07:49:56 INFO - 2015-12-18 07:49:56,288 DEBUG : BROWSER_OUTPUT: RSS: Main: 229081088 07:49:56 INFO - 2015-12-18 07:49:56,288 DEBUG : BROWSER_OUTPUT: 07:52:58 INFO - 2015-12-18 07:52:58,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41477/tests/dromaeo/cssquery-mootools.html) 07:52:58 INFO - 2015-12-18 07:52:58,792 DEBUG : BROWSER_OUTPUT: RSS: Main: 229261312 07:52:58 INFO - 2015-12-18 07:52:58,792 DEBUG : BROWSER_OUTPUT: 07:56:00 INFO - 2015-12-18 07:56:00,738 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41477/tests/dromaeo/cssquery-prototype.html) 07:56:01 INFO - 2015-12-18 07:56:01,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 210391040 07:56:01 INFO - 2015-12-18 07:56:01,319 DEBUG : BROWSER_OUTPUT: 07:59:04 INFO - 2015-12-18 07:59:04,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41477/tests/dromaeo/cssquery-yui.html) 07:59:04 INFO - 2015-12-18 07:59:04,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 217235456 07:59:04 INFO - 2015-12-18 07:59:04,631 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,249 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/dromaeo/cssquery-yui.html (next: http://localhost:41477/tests/dromaeo/cssquery-dojo.html) 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 260726784 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2652.2838833514948;2735.8358498490093;2738.30173305807;2753.9173824785253;2762.419891822717;4500.0999800040045;4607.193741095311;4729.929051064232;4767.761611919399;4788.880277993052;4722.64580156488;4830.468648448667;4842.0557991191645;4863.051704917542;4870.050340183666;4356.7821608919585;4357.956420435787;4426.336049592571;4438.667099967499;4517.661175411841;4303.419038429804;4463.174312752151;4470.7094038887535;4474.060447306053;4474.507804141542;4225.9788701056295;4335.111302183045;4407.713498622579;4454.643628509744;4498.50516443191;4335.436393268887;4422.933655995163;4432.778361081933;4452.821887124511;4457.531959144308;4396.626286765629;4418.248897687401;4419.535948725402;4422.601965823059;4469;4426.867193984185;4526.705764125354;4546.499885012646;4736.763161841928;4750.263709125091;5030.220315851049;5100.056489549445;5103.362079740033;5111.4121875984365;5127.4359820420095;5210.635255532115;5217.2695822584865;5224.738763061831;5225.869353266161;5276;4540.614047805908;4832.057748739033;4833.275008748646;4833.613310935152;4877.951220487786;5109.054824857413;5140.306058682105;5237.633365664443;5313.203019547099;5375.462453754593;5056.6713163644245;5074.923876141861;5078.898422031612;5081.110805609003;5121.8463446096675;4832.613390928787;5161.896762064737;5167.3799144102195;5168.095583272912;5173.198154286091;4894.779734911937;4900.019996000814;4974.104661161025;5052.494750524918;5082.695038297714;4960.404751429852;4992.176290912032;5001.7499125043605;5003.149464591028;5048.469910659402;4031.677465802729;4185.142045880587;4220.915581688349;4220.978895105566;4262.104957958802;3666.944995825065;3685.649863262986;3705.629437056327;3770.3024940385567;3782.867599634;4414.690971631955;4432.933505997413;4438.423005009393;4442.8667139985855;4481.014176881146;5189.143791274473;5204.34945631796;5205.401378841406;5211.478852114758;5254.13306804373;4223.577642235752;4324.459442569679;4328.458942632171;4334.891627709332;4437.356583295404;4497.3254011897825;4503.482099558527;4536.4102666653125;4546.249868771615;4593.931091033637;4772.260299653559;4776.665633405698;4783.067301876101;4791.329213910055;4835.468098509091;4807.471178170468;4903.239997800347;4909.877253068702;4947.529984651453;5106.923396148986;4824.34871292371;4836.782344794422;4838.03239352138;4872.244802055687;4874.902501950012;5069.898602028013;5070.036693028313;5072.442031376472;5073.898522029465;5079.593632509316;4906.116898958222;5034.949650503448;5046.77289521965;5082.949170508247;5166.560842328444;5023.874403139951;5025.522575355335;5031.195008798574;5033.144365457808;5045.747712614428;5016.749162541785;5019.472955339636;5019.648624596243;5020.824271150492;5057.241413787961;4614.538546145359;4745.098431298043;4775.188218002879;4810.927836082532;4932.7286999215385;4955.207166853286;4956.82651107224;4957.082939656175;4966.528179822911;4969;4851.248056551241;4857.125717370907;4857.198562237191;4857.53853383928;4899.828506002273 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.4768891086833;561.4918498758625;568.8947544704228;581.488290304532;583.0583607473928;24572.87713561432;34255;35239.647603523954;35341.11647208821;35349.82325088374;39669.80165099171;40207.39688904661;40267.59732402675;40299.59700402995;40319.39520907189;6990.6155161466095;7123.180834204081;7880.290773830354;8006.6797328107095;8046.994125734283;10194.388336699785;10469.581216751321;10470.5288262028;10471.790564188712;10481.161507079416;9955.203583713323;10038.598456061749;10041.447720375376;10081;10122;7242.565446073252;7426;9836.458994755285;10003.699889003341;10097.747556311078;9654.324197306192;9767.560459779326;9780.657676981342;9784.119429251401;9788.119069283799;33420;33780.662193378;33859.492107618404;33923;33965.32069358599;2959.8668059937354;3016.577679124924;3024.909252722422;3152.2119470132466;3453.309338132384;28240.435191296263;28248.435031299465;28444.573331400046;28613.570796437863;28984.710152898413;3391.5421418108485;3458.723302135823;3475.94786078209;3585.1395665040463;3588.0132963435003;216548;217748;217992;218125;218257;51097.48902510927;52692.20961685578;54791.72604137033;56068.43931560714;56352.43647563472;48513.5148648509;48951;49141.75429122903;49170.75414622904;49195;13857.307134643228;13943.511977080956;14041.297935103408;14068.577942661532;14102.083364581269;10654.680359589225;10809.83785243222;10821.67534973952;10900.345979241112;10927.508262128224;18987.145578449003;19077.713834292495;19095.80904190968;19137.425877223704;19138;6971.198312194163;7286.198518162998;7330.743423980135;7357.5217610855125;7417.443691723034;833.9416240863081;875.8554838451585;888.1118881118881;953.0897992417225;957.5020989085637;25331.493370132495;25759;26004;26007;26536.867315663298;927.874736910522;928.1739252065667;964.8022155458115;981.0630847540582;1043.2384359417667;13234.536791212262;13472.865271347357;13483.19100853952;13495.865041349658;14059.367328470244;271310;276703;277188;277391;278326;38954.610453895664;39411;43951;44782;45102.77448612736;1144.3877525523806;1159.8492196014465;1186.8694443611196;1199.1785626845638;1206.4269472000906;22668;23398.64902026505;24047.51904961926;24140.51718965646;24207.51584968326;36181.27637447289;37072.25855482929;40927;42425.78787106045;42460.575394246895;159976;161292;162059;162116;162331;25720.22839314749;26045;26058.478830422908;26084.73915260899;26088.73911260863;34966.12584685403;35127.47308790421;35134.12164695903;35533.46699799453;35856.64143358533;31960.84019579887;32825.83587082049;32989;33280.334393312485;33534.49698254577;30345.39309213759;30805.383892322476;30924.69075309218;31011;31016.53475197919;31058.37883242277;31201.219969500944;33090.50364244587;33696.15759606029;33830.66169338275;24741.381465463506;26329;26582.202533924014;26603.733962660124;27091.864540677172;22412.551748965256;24623.261302160965;24642.876785615957;24723.62914556319;25104.62343064892 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: |2;jquery.html;316.5599816255404;319.5558174137947;320.8524078923695;323.35490696061345;325.5409872080367;12119.394030298472;12440.564580239694;14951.47669831556;15167.62080947977;15316.923415382935;14042.94677899159;14355.78466323006;14421;14860.182689952075;14873.181974991372;3886.3587508061137;4863.29482225078;5001.349824522807;5010.323606313137;5105.3873535175835;5031.22016087507;5067.290579318898;5073.543381095701;5076.796928122871;5085.084684756743;4897.657163998521;5004.774785134659;5011.373578302712;5032.57223136032;5056.570191533724;4992.925106123411;5008.774605142759;5044.697318160922;5046.419661738873;5051.520105589963;4361.563843615645;4444.822207111712;4450.732956022616;4473.038296766211;4500.122476117159;18918.527036824053;19190.52023699405;19201.61596768057;19206.90396548022;19355.80644193554;1815.582416044304;1858.5632376391536;1876.492326592885;1908.055512521297;1931.64264611046;12146.635600931986;12369.814452783216;12370.62888113358;12412.379381031004;12916.612501624872;1705.4031089118832;1717.9914100429544;1719.72484402495;1726.421648747671;1728.809830918598;52057.21914171291;53503.732481337734;53628;54437.72781136069;54793.45206547963;8938.1508756668;8994.595243214071;9001.459912405277;9008.099190080939;9075.364724469224;9898.554565044591;10208.928062553474;10486.213533984981;11150.721231969266;11205.775884482428;6765.9661701691175;6808.319168083152;6870.484713646497;6911.067005954132;6928.376446119873;6775;6787.2534021257625;6837.2820853809635;6839.897401538981;6852.725890964306;5357.330333708286;5387.542058924957;5456.836294911159;5525.364583072998;5599.384067752544;1494.290212149242;1528;1542.4293011585785;1543.7838702581648;1555.9455419060278;794.3803833010261;869.3827382558328;884.8141890203129;930.4277869110448;946.611889125469;15203.61990950213;15703.371865125268;15954.441594544367;16369.181540923144;16641.66716665684;709.3013381818904;821.8150916043842;839.6725277141919;864.9610767515477;886.5965985476593;7955.602219889098;8118.634661440249;8239.423240373237;8313.667453301921;8365.330773538102;482572;490844;492307;521330;527661;72883;74097;75675.62162189154;76235;77298;1054.715226888751;1062.7715041266165;1066.36018388966;1086.8152414089623;1087.8041952448477;11847.466863991314;13505.527306544223;14184.290785460893;14219.146851188962;14433.855661443671;24765.87617061903;26039.869800650875;30265.848670756506;33976.83011585025;34013.82993085019;32989.90643775919;33375.83312083521;33390.49914251337;33695.66304337023;34343.82828085944;8382.455140415854;8473.603003959664;8503.829923401374;8601.870971935552;8614.052454230155;10032.197424206191;10136.239782016526;13058.281794501014;15561;15955.680886381975;13021.934890325489;13365.799513007118;13447.327633618084;13492.190468571525;13501.189928604315;12958.22250664963;13116.213027218397;13405.262710551013;13414.731705366034;13801.86198138046;13268.601941941757;13398.129121607064;13564.728705426034;13643.044986850826;13919.582412527641;8457.534835584102;8483.98192216938;8553.31573474133;8585.441946273471;8720.694775683074;9046.63813447481;9211.677591284273;9223.86164207524;12044.21712588679;13587.184768913898 08:02:07 INFO - 2015-12-18 08:02:07,507 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1202.9097817663678;1610.4363472784523;1664.7336426171807;1675.857552108071;1706.0360896093707;5782.884342313151;6989.790306290813;7133.215346311901;7150.07049083619;7153.821154471128;7037.929620703791;7209.495335326516;7220.963895180516;7232.710691572344;7238.529495582783;1771.5305444057335;1798.1099355818822;2007.0366224212387;2009.9698504522407;2043.6014977079476;2107.2729908181727;2139.732533433321;2141.6573348264283;2144.04589957469;2144.5603651251536;2014.4963759060236;2064.205280966831;2072.264346157115;2072.5647614001005;2076;2040.4082815983347;2051.0257627626906;2069.4929742213103;2080.240712140073;2080.864743791649;2136.7329083864515;2145.8712477251415;2151.429871084164;2152.35429371188;2158.3417057797524;7005.719771209146;7053.0830991971225;7084.149902011792;7084.326988936043;7096.53872498286;4165.770882601456;4233.343831706091;4263.87208383749;4264.594863487963;4273.594008569181;2669.3193235724766;2688.2607282997137;2713.91858244253;2718.0215122555865;2739.7123302053196;868.2055918834259;873.724776695339;877.8858748362736;894.7136916186823;901.2609660078738;9609.087136722;9675.129238368581;9759.072888075621;9766.36518626287;9782.217422606174;3908.3160446921675;3917.5494818096286;3947.4473573699706;3974.1455587048345;3974.721769476109;8479.618417171243;8482.787930301793;8484.40609157353;8494.617742201615;8514.78713032179;4278.507971583308;4285.892852678646;4302.612764851178;4305.117450922553;4311.461067366579;3877.7091718121255;3879.9612003880166;3880.728349015542;3891.299566078133;3922.627350401707;2946.6905974872757;2978.955315670267;3328.9001329959656;3353.8155401453155;3399.5750531183603;1097.7145942054963;1121.0695123047851;1124.696331990358;1133.7279053027214;1135.8807325230896;994.125169850527;1095.2606990281529;1163.790517706821;1180.2446434282067;1183.627157445402;6759.493038022069;6825.658717064127;6827.761028363983;6833.5216534843075;6848.246692863781;560.1653536230987;574.3280361976498;579.8927198468213;580.5848818095083;720.4452571520005;5034.219695947134;5035.420926593415;5104.05574968632;5112.335396398445;5113.079645663816;8272.751817445485;8756.4308319959;8777.51723655205;8778.648854045894;8799.912000880036;8731.563421828883;8732.78168045804;8736.56317184151;8738.69414570487;8756.8686469703;6761.357671021246;6810.931890681129;6845.5550389224545;6922.446204303644;6927.618980956096;6535.640539770358;6578.375054369827;6584.473242140713;6591.209054913249;6592.868142637216;7697.538147711155;7977.521348719096;7977.7207797729125;7979.84040319202;7990.04119505663;7924.6037698116015;8106.338200668731;8223.794405139919;8256.422050456411;8267.255946964802;6411.6153030818305;6428.067930150196;6451.70967306463;6458.903116453163;6518.674066296571;5528.198411230269;5809.5352371811;6467.773627923;6610.438112760469;7033.156021277479;6133.4786543142545;6326.525510586816;6362.904556431565;6474.449671777763;6479.157709497735;6304.621722696653;6446;6495.220573531206;6529.412352888263;6554.279029306867;6343.873122537616;6358.268799088164;6358.872822543616;6365.936340636719;6369.394907483782;5896.115582662635;5918.082697181943;5928;5929.525637948867;5938.109283607493;5925.703714814156;6017.548683848817;6042.939570604238;6061.787837425669;6107.328193898757 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: |4;prototype.html;293.903012006038;296.0924765593456;299.30411792582254;305.2369077306733;307.1568544345771;5234.057869583474;5261.947380526193;5327.840164795062;5354.759035843386;5365.463453654637;4992.201247800353;5116.232565115234;5142.460041695625;5252;5286.735663216833;4052.9189416211657;4060.1879624075154;4063.674906007512;4071.246819338417;4079.4288799568085;3909.2181563687377;4077.3476243800997;4077.368007958771;4086.1419101988618;4087.6116768906904;3947.4868267125375;3970.047188674712;4053.4730485037053;4054.776987265699;4058.9188216235807;4035.616616421435;4048.5748996355255;4051.9464939115746;4053.391991201314;4054.2702313583545;3529.6293889141525;3532.6643968822923;3533.9293214135573;3540.061883600848;3550.1657110578994;5059.848204553869;5088.236764485357;5102.311187989611;5109.105906466353;5117.309163262949;4551.3173024046655;4654.371659825948;4661.510541393172;4669.042846216517;4669.579737823578;5537.58468114889;5538.778448862081;5539.307586551681;5540.722963851832;5544.77820887168;3865.439511270878;3866.130120722843;3866.980665096685;3868.651821336065;3871.5741268460447;5817.796377126822;5820.097884827858;5824.980628390057;5827.067669172912;5829.766809327622;3871.7676939383728;3976.960230397659;3979.263836190314;3984.8007599619905;3995.1011022520283;4042.959570404258;4043.8584649537124;4043.939340909889;4044.130511939888;4047.817848196838;4627.930581041287;4628.3288923105965;4632.2819962905805;4634.073185362873;4634.536546345406;5554.527865131428;5556.805511807148;5557.722113894289;5558.388577256498;5569.610127291132;1419.637992311954;1427.2578259305103;1446.9059511131743;1456.4611093895326;1460.7224627320775;969.1713584884822;971.0823272008026;987.4618333008527;993.2401712689798;994.557421947241;4887.706737595685;4891.706497610155;4892.584130348961;4895.632827537949;4897.8285759998225;5762.481376676119;5780.16187652788;5786.71066446676;5788.27646544182;5795.797147099831;4759.857204283877;4816.783244753994;4859.829905953346;4899.191633380452;4899.779509922062;3103.7827352085587;3128.906132816019;3136.2629782001213;3137.0902438292637;3145.622525296979;5447.863803404867;5458.9454105458435;5462.754176062087;5473.397926228112;5473.616846820684;5963.0459126539545;5968.940310596839;5971.402859713994;5975.4024597540765;5976;5346.4118946915805;5489.066858633962;5502.119660854244;5503.532199763065;5513.61404701667;5784.595078344475;5828.417158284137;5840.445157710011;5849.356570777296;5854.063349864001;5680.914786278292;5701.8859622806485;5703.857403564778;5704.11586204139;5704.1443783432815;5320.813771517978;5480.972595137158;5485.451454854483;5493.395726470165;5504.889902202013;3888.9805550972064;3892.9221415572097;3910.608939106067;3925.7251992361403;3933.3903244997073;5830.446107619939;5855.443732845373;5855.443732845373;5861.6189947653265;5872.148538461985;5653.519450846559;5653.519450846724;5656.943430565641;5657.830265092054;5659.207710920557;5492.80775172867;5633.6619802811965;5641.774329026793;5646.011947909182;5648.971755141362;5518.917216241679;5529.723513824373;5532.585056120726;5536.114221724505;5540.529055030368;5674.943250567607;5678.261825962599;5681.346645135697;5686.715664216856;5688.431156884279;5413.945860541344;5509.063459212024;5532.6680399176175;5535.6955367455175;5546.278983732089 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: |5;yui.html;719.2914978745935;736.6464097233328;762.897008903798;768.9423293253005;787.3386355461412;10784.892151078488;11016.449177541132;11020.669379918605;12242.387880605978;12540.56108036219;13103.475860965575;13207.207567545955;13226.338683065856;13226.404811783468;13237.669058273548;626.5989766549412;634.1375729008568;787.5510958753528;804.493169303341;805.6938363421891;785.3677789379548;793.6309616028545;799.0371602219312;799.8880156778056;800.1478425476878;823.5593957232882;829.2950991657074;835.5279267214034;836.477201748907;836.7029704454923;653.555582204101;663.2240278873729;811.0996793559144;821.5070957425527;831.4013909984801;619.6498978077371;620.1132380695603;620.184457438467;620.3393386043849;620.9099680546295;11186.105111591054;11253.887461125365;11258.831117533244;11283.097352211804;11297.774044519147;10485.790284194274;10807.35155890649;10925.508352124174;10993.120550356032;11261.324320540794;9114.225290850285;9151.65195158006;9350.859737103949;9409;9591.808163836755;3080.199148221456;3084.36770462057;3113.34619729857;3128.4994400895976;3219.0503801378413;39885.80057099725;39991.20017599632;40300.19399611992;40314.798426007685;40363.7981810092;8842.911570884338;8914.420562663407;8944.68693595721;9177.724668259963;9207.493587852732;15988.280527376295;16024.118673472838;16026;16042.673812297386;16058.598535036484;6052.364501727343;6200.410960958701;6200.906986395207;6309.14826498426;6388.169537960035;3391.7795343302605;3460.9480857787153;3504.1940353718787;3509.0700964244497;3527.5590551181103;2567.781738552244;2576.0468626608276;2598.9090381836922;2606.830556013853;2607.0353969031203;441.6731618602211;444.2669595167934;446.32827594470115;452.27861560810453;454.3457421313364;457.60188635886993;569.257134341705;574.2477354665401;587.9911801322984;597.4145337569206;6918.619475928772;7083.079199704005;8305.792355191168;8406.673318144152;8437.156284371515;445.97770111494947;486.2608834571502;514.8918727067282;551.9751611177506;589.3988132105229;3369.3261347730554;3584.677379035847;3640.18095928414;3675.9081022974106;3867.1298957734284;44841;45178.32232516515;45279.77360113178;45781;48228.5177148231;41507.377389339184;41820.372694409605;41964;42207.788961055616;42746.57253427426;37581.43627845585;41029.79485102615;41686.58313416827;42196.36705449482;43093.784531077144;7372.741954031583;7502.174760776201;7777.611119444118;7899.881501777363;7973.162817904036;29853.402931941673;30173;30418.84790576033;30444.543331850484;30890.691093088783;37090.44364334591;37366.62633373631;37698;38099.80950095232;38325.4251186238;9216.907830921873;9496.857547136937;9966.252531060345;10131.63659537182;10161.949190254298;11294.265872718248;11326.073793192405;11373.488193031168;11447.656570302905;11589.942050289694;9721.173700235558;9856.802863942825;10100.898991009995;10289.382637041801;10570.471476426303;10611;10755.462226888782;10810.56757729682;11002.50488727993;11008.614698485515;7607.37040824347;9890.258230632875;10333;10667.573297068031;10688.412137332522;8753.693620723245;8899.822003560022;9218.492982886006;9219.17027467531;9222.354435189472;8829.117088291376;8899.110088991049;8925.419847709878;8952.68665596701;9072.727818165466 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,845 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454527500__endTimestamp 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: Number of tests: 6 08:02:07 INFO - 2015-12-18 08:02:07,508 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,509 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4703.32 Median:4835.47 stddev:495.38 (10.2%) stddev-sans-first:470.04 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: Values: 2652.3 2735.8 2738.3 2753.9 2762.4 4500.1 4607.2 4729.9 4767.8 4788.9 4722.6 4830.5 4842.1 4863.1 4870.1 4356.8 4358.0 4426.3 4438.7 4517.7 4303.4 4463.2 4470.7 4474.1 4474.5 4226.0 4335.1 4407.7 4454.6 4498.5 4335.4 4422.9 4432.8 4452.8 4457.5 4396.6 4418.2 4419.5 4422.6 4469.0 4426.9 4526.7 4546.5 4736.8 4750.3 5030.2 5100.1 5103.4 5111.4 5127.4 5210.6 5217.3 5224.7 5225.9 5276.0 4540.6 4832.1 4833.3 4833.6 4878.0 5109.1 5140.3 5237.6 5313.2 5375.5 5056.7 5074.9 5078.9 5081.1 5121.8 4832.6 5161.9 5167.4 5168.1 5173.2 4894.8 4900.0 4974.1 5052.5 5082.7 4960.4 4992.2 5001.7 5003.1 5048.5 4031.7 4185.1 4220.9 4221.0 4262.1 3666.9 3685.6 3705.6 3770.3 3782.9 4414.7 4432.9 4438.4 4442.9 4481.0 5189.1 5204.3 5205.4 5211.5 5254.1 4223.6 4324.5 4328.5 4334.9 4437.4 4497.3 4503.5 4536.4 4546.2 4593.9 4772.3 4776.7 4783.1 4791.3 4835.5 4807.5 4903.2 4909.9 4947.5 5106.9 4824.3 4836.8 4838.0 4872.2 4874.9 5069.9 5070.0 5072.4 5073.9 5079.6 4906.1 5034.9 5046.8 5082.9 5166.6 5023.9 5025.5 5031.2 5033.1 5045.7 5016.7 5019.5 5019.6 5020.8 5057.2 4614.5 4745.1 4775.2 4810.9 4932.7 4955.2 4956.8 4957.1 4966.5 4969.0 4851.2 4857.1 4857.2 4857.5 4899.8 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:37663.25 Median:31037.46 stddev:58151.12 (187.4%) stddev-sans-first:58247.51 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: Values: 559.5 561.5 568.9 581.5 583.1 24572.9 34255.0 35239.6 35341.1 35349.8 39669.8 40207.4 40267.6 40299.6 40319.4 6990.6 7123.2 7880.3 8006.7 8047.0 10194.4 10469.6 10470.5 10471.8 10481.2 9955.2 10038.6 10041.4 10081.0 10122.0 7242.6 7426.0 9836.5 10003.7 10097.7 9654.3 9767.6 9780.7 9784.1 9788.1 33420.0 33780.7 33859.5 33923.0 33965.3 2959.9 3016.6 3024.9 3152.2 3453.3 28240.4 28248.4 28444.6 28613.6 28984.7 3391.5 3458.7 3475.9 3585.1 3588.0 216548.0 217748.0 217992.0 218125.0 218257.0 51097.5 52692.2 54791.7 56068.4 56352.4 48513.5 48951.0 49141.8 49170.8 49195.0 13857.3 13943.5 14041.3 14068.6 14102.1 10654.7 10809.8 10821.7 10900.3 10927.5 18987.1 19077.7 19095.8 19137.4 19138.0 6971.2 7286.2 7330.7 7357.5 7417.4 833.9 875.9 888.1 953.1 957.5 25331.5 25759.0 26004.0 26007.0 26536.9 927.9 928.2 964.8 981.1 1043.2 13234.5 13472.9 13483.2 13495.9 14059.4 271310.0 276703.0 277188.0 277391.0 278326.0 38954.6 39411.0 43951.0 44782.0 45102.8 1144.4 1159.8 1186.9 1199.2 1206.4 22668.0 23398.6 24047.5 24140.5 24207.5 36181.3 37072.3 40927.0 42425.8 42460.6 159976.0 161292.0 162059.0 162116.0 162331.0 25720.2 26045.0 26058.5 26084.7 26088.7 34966.1 35127.5 35134.1 35533.5 35856.6 31960.8 32825.8 32989.0 33280.3 33534.5 30345.4 30805.4 30924.7 31011.0 31016.5 31058.4 31201.2 33090.5 33696.2 33830.7 24741.4 26329.0 26582.2 26603.7 27091.9 22412.6 24623.3 24642.9 24723.6 25104.6 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,510 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26260.23 Median:19115.09 stddev:82199.44 (430.0%) stddev-sans-first:82406.94 08:02:07 INFO - 2015-12-18 08:02:07,511 DEBUG : BROWSER_OUTPUT: Values: 316.6 319.6 320.9 323.4 325.5 12119.4 12440.6 14951.5 15167.6 15316.9 14042.9 14355.8 14421.0 14860.2 14873.2 3886.4 4863.3 5001.3 5010.3 5105.4 5031.2 5067.3 5073.5 5076.8 5085.1 4897.7 5004.8 5011.4 5032.6 5056.6 4992.9 5008.8 5044.7 5046.4 5051.5 4361.6 4444.8 4450.7 4473.0 4500.1 18918.5 19190.5 19201.6 19206.9 19355.8 1815.6 1858.6 1876.5 1908.1 1931.6 12146.6 12369.8 12370.6 12412.4 12916.6 1705.4 1718.0 1719.7 1726.4 1728.8 52057.2 53503.7 53628.0 54437.7 54793.5 8938.2 8994.6 9001.5 9008.1 9075.4 9898.6 10208.9 10486.2 11150.7 11205.8 6766.0 6808.3 6870.5 6911.1 6928.4 6775.0 6787.3 6837.3 6839.9 6852.7 5357.3 5387.5 5456.8 5525.4 5599.4 1494.3 1528.0 1542.4 1543.8 1555.9 794.4 869.4 884.8 930.4 946.6 15203.6 15703.4 15954.4 16369.2 16641.7 709.3 821.8 839.7 865.0 886.6 7955.6 8118.6 8239.4 8313.7 8365.3 482572.0 490844.0 492307.0 521330.0 527661.0 72883.0 74097.0 75675.6 76235.0 77298.0 1054.7 1062.8 1066.4 1086.8 1087.8 11847.5 13505.5 14184.3 14219.1 14433.9 24765.9 26039.9 30265.8 33976.8 34013.8 32989.9 33375.8 33390.5 33695.7 34343.8 8382.5 8473.6 8503.8 8601.9 8614.1 10032.2 10136.2 13058.3 15561.0 15955.7 13021.9 13365.8 13447.3 13492.2 13501.2 12958.2 13116.2 13405.3 13414.7 13801.9 13268.6 13398.1 13564.7 13643.0 13919.6 8457.5 8484.0 8553.3 8585.4 8720.7 9046.6 9211.7 9223.9 12044.2 13587.2 08:02:07 INFO - 2015-12-18 08:02:07,511 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,511 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4997.92 Median:6120.40 stddev:2629.47 (43.0%) stddev-sans-first:2621.37 08:02:07 INFO - 2015-12-18 08:02:07,512 DEBUG : BROWSER_OUTPUT: Values: 1202.9 1610.4 1664.7 1675.9 1706.0 5782.9 6989.8 7133.2 7150.1 7153.8 7037.9 7209.5 7221.0 7232.7 7238.5 1771.5 1798.1 2007.0 2010.0 2043.6 2107.3 2139.7 2141.7 2144.0 2144.6 2014.5 2064.2 2072.3 2072.6 2076.0 2040.4 2051.0 2069.5 2080.2 2080.9 2136.7 2145.9 2151.4 2152.4 2158.3 7005.7 7053.1 7084.1 7084.3 7096.5 4165.8 4233.3 4263.9 4264.6 4273.6 2669.3 2688.3 2713.9 2718.0 2739.7 868.2 873.7 877.9 894.7 901.3 9609.1 9675.1 9759.1 9766.4 9782.2 3908.3 3917.5 3947.4 3974.1 3974.7 8479.6 8482.8 8484.4 8494.6 8514.8 4278.5 4285.9 4302.6 4305.1 4311.5 3877.7 3880.0 3880.7 3891.3 3922.6 2946.7 2979.0 3328.9 3353.8 3399.6 1097.7 1121.1 1124.7 1133.7 1135.9 994.1 1095.3 1163.8 1180.2 1183.6 6759.5 6825.7 6827.8 6833.5 6848.2 560.2 574.3 579.9 580.6 720.4 5034.2 5035.4 5104.1 5112.3 5113.1 8272.8 8756.4 8777.5 8778.6 8799.9 8731.6 8732.8 8736.6 8738.7 8756.9 6761.4 6810.9 6845.6 6922.4 6927.6 6535.6 6578.4 6584.5 6591.2 6592.9 7697.5 7977.5 7977.7 7979.8 7990.0 7924.6 8106.3 8223.8 8256.4 8267.3 6411.6 6428.1 6451.7 6458.9 6518.7 5528.2 5809.5 6467.8 6610.4 7033.2 6133.5 6326.5 6362.9 6474.4 6479.2 6304.6 6446.0 6495.2 6529.4 6554.3 6343.9 6358.3 6358.9 6365.9 6369.4 5896.1 5918.1 5928.0 5929.5 5938.1 5925.7 6017.5 6042.9 6061.8 6107.3 08:02:07 INFO - 2015-12-18 08:02:07,512 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,512 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4621.53 Median:5274.34 stddev:1369.58 (26.0%) stddev-sans-first:1334.34 08:02:07 INFO - 2015-12-18 08:02:07,513 DEBUG : BROWSER_OUTPUT: Values: 293.9 296.1 299.3 305.2 307.2 5234.1 5261.9 5327.8 5354.8 5365.5 4992.2 5116.2 5142.5 5252.0 5286.7 4052.9 4060.2 4063.7 4071.2 4079.4 3909.2 4077.3 4077.4 4086.1 4087.6 3947.5 3970.0 4053.5 4054.8 4058.9 4035.6 4048.6 4051.9 4053.4 4054.3 3529.6 3532.7 3533.9 3540.1 3550.2 5059.8 5088.2 5102.3 5109.1 5117.3 4551.3 4654.4 4661.5 4669.0 4669.6 5537.6 5538.8 5539.3 5540.7 5544.8 3865.4 3866.1 3867.0 3868.7 3871.6 5817.8 5820.1 5825.0 5827.1 5829.8 3871.8 3977.0 3979.3 3984.8 3995.1 4043.0 4043.9 4043.9 4044.1 4047.8 4627.9 4628.3 4632.3 4634.1 4634.5 5554.5 5556.8 5557.7 5558.4 5569.6 1419.6 1427.3 1446.9 1456.5 1460.7 969.2 971.1 987.5 993.2 994.6 4887.7 4891.7 4892.6 4895.6 4897.8 5762.5 5780.2 5786.7 5788.3 5795.8 4759.9 4816.8 4859.8 4899.2 4899.8 3103.8 3128.9 3136.3 3137.1 3145.6 5447.9 5458.9 5462.8 5473.4 5473.6 5963.0 5968.9 5971.4 5975.4 5976.0 5346.4 5489.1 5502.1 5503.5 5513.6 5784.6 5828.4 5840.4 5849.4 5854.1 5680.9 5701.9 5703.9 5704.1 5704.1 5320.8 5481.0 5485.5 5493.4 5504.9 3889.0 3892.9 3910.6 3925.7 3933.4 5830.4 5855.4 5855.4 5861.6 5872.1 5653.5 5653.5 5656.9 5657.8 5659.2 5492.8 5633.7 5641.8 5646.0 5649.0 5518.9 5529.7 5532.6 5536.1 5540.5 5674.9 5678.3 5681.3 5686.7 5688.4 5413.9 5509.1 5532.7 5535.7 5546.3 08:02:07 INFO - 2015-12-18 08:02:07,513 DEBUG : BROWSER_OUTPUT: 08:02:07 INFO - 2015-12-18 08:02:07,513 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11919.35 Median:446.15 stddev:13266.75 (2973.6%) stddev-sans-first:13277.31 08:02:07 INFO - 2015-12-18 08:02:07,515 DEBUG : BROWSER_OUTPUT: Values: 719.3 736.6 762.9 768.9 787.3 10784.9 11016.4 11020.7 12242.4 12540.6 13103.5 13207.2 13226.3 13226.4 13237.7 626.6 634.1 787.6 804.5 805.7 785.4 793.6 799.0 799.9 800.1 823.6 829.3 835.5 836.5 836.7 653.6 663.2 811.1 821.5 831.4 619.6 620.1 620.2 620.3 620.9 11186.1 11253.9 11258.8 11283.1 11297.8 10485.8 10807.4 10925.5 10993.1 11261.3 9114.2 9151.7 9350.9 9409.0 9591.8 3080.2 3084.4 3113.3 3128.5 3219.1 39885.8 39991.2 40300.2 40314.8 40363.8 8842.9 8914.4 8944.7 9177.7 9207.5 15988.3 16024.1 16026.0 16042.7 16058.6 6052.4 6200.4 6200.9 6309.1 6388.2 3391.8 3460.9 3504.2 3509.1 3527.6 2567.8 2576.0 2598.9 2606.8 2607.0 441.7 444.3 446.3 452.3 454.3 457.6 569.3 574.2 588.0 597.4 6918.6 7083.1 8305.8 8406.7 8437.2 446.0 486.3 514.9 552.0 589.4 3369.3 3584.7 3640.2 3675.9 3867.1 44841.0 45178.3 45279.8 45781.0 48228.5 41507.4 41820.4 41964.0 42207.8 42746.6 37581.4 41029.8 41686.6 42196.4 43093.8 7372.7 7502.2 7777.6 7899.9 7973.2 29853.4 30173.0 30418.8 30444.5 30890.7 37090.4 37366.6 37698.0 38099.8 38325.4 9216.9 9496.9 9966.3 10131.6 10161.9 11294.3 11326.1 11373.5 11447.7 11589.9 9721.2 9856.8 10100.9 10289.4 10570.5 10611.0 10755.5 10810.6 11002.5 11008.6 7607.4 9890.3 10333.0 10667.6 10688.4 8753.7 8899.8 9218.5 9219.2 9222.4 8829.1 8899.1 8925.4 8952.7 9072.7 08:02:07 INFO - 2015-12-18 08:02:07,515 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:02:07 INFO - 2015-12-18 08:02:07,515 DEBUG : BROWSER_OUTPUT: 08:02:08 INFO - 2015-12-18 08:02:08,247 INFO : Browser exited with error code: 0 08:02:08 INFO - 2015-12-18 08:02:08,265 INFO : Completed test dromaeo_css (00:18:37) 08:02:08 INFO - 2015-12-18 08:02:08,265 INFO : Starting test kraken 08:02:08 INFO - 2015-12-18 08:02:08,265 DEBUG : operating with platform_type : linux_ 08:02:08 INFO - 2015-12-18 08:02:08,266 INFO : Initialising browser for kraken test... 08:02:08 INFO - 2015-12-18 08:02:08,272 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUKRhN/profile http://localhost:41477/getInfo.html 08:02:12 INFO - 2015-12-18 08:02:12,166 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:02:12 INFO - 2015-12-18 08:02:12,166 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:02:12 INFO - 2015-12-18 08:02:12,166 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:02:12 INFO - 2015-12-18 08:02:12,166 DEBUG : BROWSER_OUTPUT: __metrics 08:02:12 INFO - 2015-12-18 08:02:12,243 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] 08:02:12 INFO - 2015-12-18 08:02:12,303 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:02:13 INFO - 2015-12-18 08:02:13,441 INFO : Browser initialized. 08:02:13 INFO - 2015-12-18 08:02:13,441 INFO : Running cycle 1/1 for kraken test... 08:02:13 INFO - 2015-12-18 08:02:13,441 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBUKRhN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:02:25 INFO - 2015-12-18 08:02:25,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 150257664 08:02:25 INFO - 2015-12-18 08:02:25,374 DEBUG : BROWSER_OUTPUT: 08:02:27 INFO - 2015-12-18 08:02:27,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41477/tests/kraken/driver.html?testName=audio-beat-detection) 08:02:28 INFO - 2015-12-18 08:02:28,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 186593280 08:02:28 INFO - 2015-12-18 08:02:28,576 DEBUG : BROWSER_OUTPUT: 08:02:31 INFO - 2015-12-18 08:02:31,273 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41477/tests/kraken/driver.html?testName=audio-dft) 08:02:31 INFO - 2015-12-18 08:02:31,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 175173632 08:02:31 INFO - 2015-12-18 08:02:31,854 DEBUG : BROWSER_OUTPUT: 08:02:34 INFO - 2015-12-18 08:02:34,865 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41477/tests/kraken/driver.html?testName=audio-fft) 08:02:35 INFO - 2015-12-18 08:02:35,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 161439744 08:02:35 INFO - 2015-12-18 08:02:35,431 DEBUG : BROWSER_OUTPUT: 08:02:37 INFO - 2015-12-18 08:02:37,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41477/tests/kraken/driver.html?testName=audio-oscillator) 08:02:38 INFO - 2015-12-18 08:02:38,047 DEBUG : BROWSER_OUTPUT: RSS: Main: 163123200 08:02:38 INFO - 2015-12-18 08:02:38,047 DEBUG : BROWSER_OUTPUT: 08:02:40 INFO - 2015-12-18 08:02:40,301 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41477/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:02:40 INFO - 2015-12-18 08:02:40,864 DEBUG : BROWSER_OUTPUT: RSS: Main: 164507648 08:02:40 INFO - 2015-12-18 08:02:40,864 DEBUG : BROWSER_OUTPUT: 08:02:43 INFO - 2015-12-18 08:02:43,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41477/tests/kraken/driver.html?testName=imaging-darkroom) 08:02:44 INFO - 2015-12-18 08:02:44,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 164184064 08:02:44 INFO - 2015-12-18 08:02:44,409 DEBUG : BROWSER_OUTPUT: 08:02:47 INFO - 2015-12-18 08:02:47,791 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41477/tests/kraken/driver.html?testName=imaging-desaturate) 08:02:48 INFO - 2015-12-18 08:02:48,372 DEBUG : BROWSER_OUTPUT: RSS: Main: 165670912 08:02:48 INFO - 2015-12-18 08:02:48,372 DEBUG : BROWSER_OUTPUT: 08:02:51 INFO - 2015-12-18 08:02:51,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41477/tests/kraken/driver.html?testName=json-parse-financial) 08:02:51 INFO - 2015-12-18 08:02:51,794 DEBUG : BROWSER_OUTPUT: RSS: Main: 166830080 08:02:51 INFO - 2015-12-18 08:02:51,794 DEBUG : BROWSER_OUTPUT: 08:02:53 INFO - 2015-12-18 08:02:53,579 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41477/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:02:54 INFO - 2015-12-18 08:02:54,161 DEBUG : BROWSER_OUTPUT: RSS: Main: 176680960 08:02:54 INFO - 2015-12-18 08:02:54,161 DEBUG : BROWSER_OUTPUT: 08:02:56 INFO - 2015-12-18 08:02:56,032 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:02:56 INFO - 2015-12-18 08:02:56,620 DEBUG : BROWSER_OUTPUT: RSS: Main: 175046656 08:02:56 INFO - 2015-12-18 08:02:56,621 DEBUG : BROWSER_OUTPUT: 08:02:58 INFO - 2015-12-18 08:02:58,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:02:59 INFO - 2015-12-18 08:02:59,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 186150912 08:02:59 INFO - 2015-12-18 08:02:59,294 DEBUG : BROWSER_OUTPUT: 08:03:01 INFO - 2015-12-18 08:03:01,793 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:03:02 INFO - 2015-12-18 08:03:02,383 DEBUG : BROWSER_OUTPUT: RSS: Main: 190291968 08:03:02 INFO - 2015-12-18 08:03:02,383 DEBUG : BROWSER_OUTPUT: 08:03:04 INFO - 2015-12-18 08:03:04,918 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:03:05 INFO - 2015-12-18 08:03:05,493 DEBUG : BROWSER_OUTPUT: RSS: Main: 186384384 08:03:05 INFO - 2015-12-18 08:03:05,493 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41477/tests/kraken/driver.html?testName=ai-astar) 08:03:07 INFO - 2015-12-18 08:03:07,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 246427648 08:03:07 INFO - 2015-12-18 08:03:07,497 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;105;110;112;112;100;111;112;119 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;150;131;152;169;134;153;149;129;167;133 08:03:07 INFO - 2015-12-18 08:03:07,498 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;160;160;160;162;161;162;162 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;83;95;72;72;76;98;102;72 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;128;94;95;95;136;97;96;135 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;109;109;109;109;109;109 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;145;147;145;146;146;147;146 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;71;73;72;72;72;72;82;70;70 08:03:07 INFO - 2015-12-18 08:03:07,499 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;68;68;67;68;68;68;70;68 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;86;84;82;84;82;84;85;85;83 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;125;127;119;116;135;122;123;122;122;135 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;135;146;147;147;135;146;146;145;135 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;70;70;70;71;68;68;69 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: __start_cc_report 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,990 08:03:07 INFO - 2015-12-18 08:03:07,500 DEBUG : BROWSER_OUTPUT: __end_cc_report 08:03:07 INFO - 2015-12-18 08:03:07,501 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454587496__endTimestamp 08:03:07 INFO - 2015-12-18 08:03:07,501 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,504 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:03:07 INFO - 2015-12-18 08:03:07,504 DEBUG : BROWSER_OUTPUT: Number of tests: 14 08:03:07 INFO - 2015-12-18 08:03:07,504 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,504 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:5.02 (4.5%) stddev-sans-first:5.32 08:03:07 INFO - 2015-12-18 08:03:07,505 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 105.0 110.0 112.0 112.0 100.0 111.0 112.0 119.0 08:03:07 INFO - 2015-12-18 08:03:07,505 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.70 Median:151.00 stddev:14.54 (9.6%) stddev-sans-first:15.37 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: Values: 150.0 131.0 152.0 169.0 134.0 153.0 149.0 129.0 167.0 133.0 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.50 stddev:0.94 (0.6%) stddev-sans-first:0.93 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 160.0 160.0 160.0 162.0 161.0 162.0 162.0 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:74.50 stddev:12.20 (16.4%) stddev-sans-first:12.55 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 83.0 95.0 72.0 72.0 76.0 98.0 102.0 72.0 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.50 Median:95.00 stddev:18.42 (19.4%) stddev-sans-first:19.06 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 128.0 94.0 95.0 95.0 136.0 97.0 96.0 135.0 08:03:07 INFO - 2015-12-18 08:03:07,506 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.00 Median:109.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.10 Median:146.00 stddev:0.74 (0.5%) stddev-sans-first:0.78 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 145.0 147.0 145.0 146.0 146.0 147.0 146.0 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:3.46 (4.8%) stddev-sans-first:3.64 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: Values: 74.0 71.0 73.0 72.0 72.0 72.0 72.0 82.0 70.0 70.0 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:67.90 Median:68.00 stddev:0.88 (1.3%) stddev-sans-first:0.87 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 68.0 67.0 68.0 68.0 68.0 70.0 68.0 08:03:07 INFO - 2015-12-18 08:03:07,507 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.32 (1.6%) stddev-sans-first:1.36 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: Values: 83.0 86.0 84.0 82.0 84.0 82.0 84.0 85.0 85.0 83.0 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.60 Median:124.00 stddev:6.24 (5.0%) stddev-sans-first:6.62 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: Values: 125.0 127.0 119.0 116.0 135.0 122.0 123.0 122.0 122.0 135.0 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.80 Median:146.00 stddev:5.41 (3.7%) stddev-sans-first:5.61 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: Values: 146.0 135.0 146.0 147.0 147.0 135.0 146.0 146.0 145.0 135.0 08:03:07 INFO - 2015-12-18 08:03:07,508 DEBUG : BROWSER_OUTPUT: 08:03:07 INFO - 2015-12-18 08:03:07,509 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.20 Median:69.50 stddev:1.03 (1.5%) stddev-sans-first:1.09 08:03:07 INFO - 2015-12-18 08:03:07,509 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 70.0 70.0 70.0 71.0 68.0 68.0 69.0 08:03:07 INFO - 2015-12-18 08:03:07,509 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:03:07 INFO - 2015-12-18 08:03:07,509 DEBUG : BROWSER_OUTPUT: 08:03:08 INFO - 2015-12-18 08:03:08,367 INFO : Browser exited with error code: 0 08:03:08 INFO - 2015-12-18 08:03:08,420 INFO : Completed test kraken (00:01:00) 08:03:08 INFO - 2015-12-18 08:03:08,420 INFO : Starting test v8_7 08:03:08 INFO - 2015-12-18 08:03:08,420 DEBUG : operating with platform_type : linux_ 08:03:08 INFO - 2015-12-18 08:03:08,420 INFO : Initialising browser for v8_7 test... 08:03:08 INFO - 2015-12-18 08:03:08,427 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JtKS_/profile http://localhost:41477/getInfo.html 08:03:12 INFO - 2015-12-18 08:03:12,844 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 08:03:12 INFO - 2015-12-18 08:03:12,844 DEBUG : BROWSER_OUTPUT: colorDepth:24 08:03:12 INFO - 2015-12-18 08:03:12,844 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 08:03:12 INFO - 2015-12-18 08:03:12,844 DEBUG : BROWSER_OUTPUT: __metrics 08:03:12 INFO - 2015-12-18 08:03:12,961 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] 08:03:13 INFO - 2015-12-18 08:03:13,023 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:03:13 INFO - 2015-12-18 08:03:13,896 INFO : Browser initialized. 08:03:13 INFO - 2015-12-18 08:03:13,896 INFO : Running cycle 1/1 for v8_7 test... 08:03:13 INFO - 2015-12-18 08:03:13,896 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JtKS_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 08:03:25 INFO - 2015-12-18 08:03:25,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 149917696 08:03:25 INFO - 2015-12-18 08:03:25,814 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,209 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41477/tests/v8_7/run.html (next: http://localhost:41477/tests/v8_7/run.html) 08:03:47 INFO - 2015-12-18 08:03:47,460 DEBUG : BROWSER_OUTPUT: RSS: Main: 456110080 08:03:47 INFO - 2015-12-18 08:03:47,460 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,460 DEBUG : BROWSER_OUTPUT: __start_tp_report 08:03:47 INFO - 2015-12-18 08:03:47,460 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 08:03:47 INFO - 2015-12-18 08:03:47,461 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 08:03:47 INFO - 2015-12-18 08:03:47,461 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 08:03:47 INFO - 2015-12-18 08:03:47,461 DEBUG : BROWSER_OUTPUT: |0;Richards;166.03021749958492 08:03:47 INFO - 2015-12-18 08:03:47,461 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.11576400521125 08:03:47 INFO - 2015-12-18 08:03:47,462 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 08:03:47 INFO - 2015-12-18 08:03:47,462 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5159.79381443299 08:03:47 INFO - 2015-12-18 08:03:47,462 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1992.03187250996 08:03:47 INFO - 2015-12-18 08:03:47,462 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 08:03:47 INFO - 2015-12-18 08:03:47,462 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: |7;RegExp;27243.243243243243 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: |8;Splay;616.1429451632779 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: __end_tp_report 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: __startTimestamp1450454627456__endTimestamp 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: Number of tests: 10 08:03:47 INFO - 2015-12-18 08:03:47,463 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.03 Median:166.03 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: Values: 166.0 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.12 Median:186.12 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: Values: 186.1 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: Values: 277.5 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5159.79 Median:5159.79 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: Values: 5159.8 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,464 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1992.03 Median:1992.03 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,465 DEBUG : BROWSER_OUTPUT: Values: 1992.0 08:03:47 INFO - 2015-12-18 08:03:47,465 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,465 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,465 DEBUG : BROWSER_OUTPUT: Values: 784.9 08:03:47 INFO - 2015-12-18 08:03:47,465 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: Values: 12243.9 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27243.24 Median:27243.24 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: Values: 27243.2 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:616.14 Median:616.14 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: Values: 616.1 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: Values: 4840.6 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 08:03:47 INFO - 2015-12-18 08:03:47,466 DEBUG : BROWSER_OUTPUT: 08:03:48 INFO - 2015-12-18 08:03:48,383 INFO : Browser exited with error code: 0 08:03:48 INFO - 2015-12-18 08:03:48,400 INFO : Completed test v8_7 (00:00:39) 08:03:48 INFO - 2015-12-18 08:03:48,499 INFO : Completed test suite (00:20:17) 08:03:48 INFO - 2015-12-18 08:03:48,500 DEBUG : Working with test: dromaeo_css 08:03:48 INFO - 2015-12-18 08:03:48,500 DEBUG : Generating results file: dromaeo_css 08:03:48 INFO - 2015-12-18 08:03:48,501 DEBUG : Working with test: kraken 08:03:48 INFO - 2015-12-18 08:03:48,501 DEBUG : Generating results file: kraken 08:03:48 INFO - 2015-12-18 08:03:48,501 INFO : javascript benchmark 08:03:48 INFO - 2015-12-18 08:03:48,501 DEBUG : Working with test: v8_7 08:03:48 INFO - 2015-12-18 08:03:48,501 DEBUG : Generating results file: v8_7 08:03:48 INFO - 2015-12-18 08:03:48,502 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:03:48 INFO - 2015-12-18 08:03:48,552 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 08:03:48 INFO - 2015-12-18 08:03:48,552 DEBUG : process_Request line: dromaeo_css 6238.67 graph.html#tests=[[72,94,35]] 08:03:48 INFO - 2015-12-18 08:03:48,552 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:03:48 INFO - 2015-12-18 08:03:48,580 DEBUG : process_Request line: kraken 1517.40 graph.html#tests=[[232,94,35]] 08:03:48 INFO - 2015-12-18 08:03:48,580 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 08:03:48 INFO - 2015-12-18 08:03:48,611 DEBUG : process_Request line: v8_7 19754.55 graph.html#tests=[[230,94,35]] 08:03:48 INFO - 2015-12-18 08:03:48,612 INFO : javascript benchmark 08:03:48 INFO - 2015-12-18 08:03:48,615 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2652.2838833514948, 2735.8358498490093, 2738.30173305807, 2753.9173824785253, 2762.419891822717, 4500.0999800040045, 4607.193741095311, 4729.929051064232, 4767.761611919399, 4788.880277993052, 4722.64580156488, 4830.468648448667, 4842.0557991191645, 4863.051704917542, 4870.050340183666, 4356.7821608919585, 4357.956420435787, 4426.336049592571, 4438.667099967499, 4517.661175411841, 4303.419038429804, 4463.174312752151, 4470.7094038887535, 4474.060447306053, 4474.507804141542, 4225.9788701056295, 4335.111302183045, 4407.713498622579, 4454.643628509744, 4498.50516443191, 4335.436393268887, 4422.933655995163, 4432.778361081933, 4452.821887124511, 4457.531959144308, 4396.626286765629, 4418.248897687401, 4419.535948725402, 4422.601965823059, 4469.0, 4426.867193984185, 4526.705764125354, 4546.499885012646, 4736.763161841928, 4750.263709125091, 5030.220315851049, 5100.056489549445, 5103.362079740033, 5111.4121875984365, 5127.4359820420095, 5210.635255532115, 5217.2695822584865, 5224.738763061831, 5225.869353266161, 5276.0, 4540.614047805908, 4832.057748739033, 4833.275008748646, 4833.613310935152, 4877.951220487786, 5109.054824857413, 5140.306058682105, 5237.633365664443, 5313.203019547099, 5375.462453754593, 5056.6713163644245, 5074.923876141861, 5078.898422031612, 5081.110805609003, 5121.8463446096675, 4832.613390928787, 5161.896762064737, 5167.3799144102195, 5168.095583272912, 5173.198154286091, 4894.779734911937, 4900.019996000814, 4974.104661161025, 5052.494750524918, 5082.695038297714, 4960.404751429852, 4992.176290912032, 5001.7499125043605, 5003.149464591028, 5048.469910659402, 4031.677465802729, 4185.142045880587, 4220.915581688349, 4220.978895105566, 4262.104957958802, 3666.944995825065, 3685.649863262986, 3705.629437056327, 3770.3024940385567, 3782.867599634, 4414.690971631955, 4432.933505997413, 4438.423005009393, 4442.8667139985855, 4481.014176881146, 5189.143791274473, 5204.34945631796, 5205.401378841406, 5211.478852114758, 5254.13306804373, 4223.577642235752, 4324.459442569679, 4328.458942632171, 4334.891627709332, 4437.356583295404, 4497.3254011897825, 4503.482099558527, 4536.4102666653125, 4546.249868771615, 4593.931091033637, 4772.260299653559, 4776.665633405698, 4783.067301876101, 4791.329213910055, 4835.468098509091, 4807.471178170468, 4903.239997800347, 4909.877253068702, 4947.529984651453, 5106.923396148986, 4824.34871292371, 4836.782344794422, 4838.03239352138, 4872.244802055687, 4874.902501950012, 5069.898602028013, 5070.036693028313, 5072.442031376472, 5073.898522029465, 5079.593632509316, 4906.116898958222, 5034.949650503448, 5046.77289521965, 5082.949170508247, 5166.560842328444, 5023.874403139951, 5025.522575355335, 5031.195008798574, 5033.144365457808, 5045.747712614428, 5016.749162541785, 5019.472955339636, 5019.648624596243, 5020.824271150492, 5057.241413787961, 4614.538546145359, 4745.098431298043, 4775.188218002879, 4810.927836082532, 4932.7286999215385, 4955.207166853286, 4956.82651107224, 4957.082939656175, 4966.528179822911, 4969.0, 4851.248056551241, 4857.125717370907, 4857.198562237191, 4857.53853383928, 4899.828506002273], "unit": "score", "name": "dojo.html", "value": 4672.463606244929}, {"lowerIsBetter": false, "replicates": [559.4768891086833, 561.4918498758625, 568.8947544704228, 581.488290304532, 583.0583607473928, 24572.87713561432, 34255.0, 35239.647603523954, 35341.11647208821, 35349.82325088374, 39669.80165099171, 40207.39688904661, 40267.59732402675, 40299.59700402995, 40319.39520907189, 6990.6155161466095, 7123.180834204081, 7880.290773830354, 8006.6797328107095, 8046.994125734283, 10194.388336699785, 10469.581216751321, 10470.5288262028, 10471.790564188712, 10481.161507079416, 9955.203583713323, 10038.598456061749, 10041.447720375376, 10081.0, 10122.0, 7242.565446073252, 7426.0, 9836.458994755285, 10003.699889003341, 10097.747556311078, 9654.324197306192, 9767.560459779326, 9780.657676981342, 9784.119429251401, 9788.119069283799, 33420.0, 33780.662193378, 33859.492107618404, 33923.0, 33965.32069358599, 2959.8668059937354, 3016.577679124924, 3024.909252722422, 3152.2119470132466, 3453.309338132384, 28240.435191296263, 28248.435031299465, 28444.573331400046, 28613.570796437863, 28984.710152898413, 3391.5421418108485, 3458.723302135823, 3475.94786078209, 3585.1395665040463, 3588.0132963435003, 216548.0, 217748.0, 217992.0, 218125.0, 218257.0, 51097.48902510927, 52692.20961685578, 54791.72604137033, 56068.43931560714, 56352.43647563472, 48513.5148648509, 48951.0, 49141.75429122903, 49170.75414622904, 49195.0, 13857.307134643228, 13943.511977080956, 14041.297935103408, 14068.577942661532, 14102.083364581269, 10654.680359589225, 10809.83785243222, 10821.67534973952, 10900.345979241112, 10927.508262128224, 18987.145578449003, 19077.713834292495, 19095.80904190968, 19137.425877223704, 19138.0, 6971.198312194163, 7286.198518162998, 7330.743423980135, 7357.5217610855125, 7417.443691723034, 833.9416240863081, 875.8554838451585, 888.1118881118881, 953.0897992417225, 957.5020989085637, 25331.493370132495, 25759.0, 26004.0, 26007.0, 26536.867315663298, 927.874736910522, 928.1739252065667, 964.8022155458115, 981.0630847540582, 1043.2384359417667, 13234.536791212262, 13472.865271347357, 13483.19100853952, 13495.865041349658, 14059.367328470244, 271310.0, 276703.0, 277188.0, 277391.0, 278326.0, 38954.610453895664, 39411.0, 43951.0, 44782.0, 45102.77448612736, 1144.3877525523806, 1159.8492196014465, 1186.8694443611196, 1199.1785626845638, 1206.4269472000906, 22668.0, 23398.64902026505, 24047.51904961926, 24140.51718965646, 24207.51584968326, 36181.27637447289, 37072.25855482929, 40927.0, 42425.78787106045, 42460.575394246895, 159976.0, 161292.0, 162059.0, 162116.0, 162331.0, 25720.22839314749, 26045.0, 26058.478830422908, 26084.73915260899, 26088.73911260863, 34966.12584685403, 35127.47308790421, 35134.12164695903, 35533.46699799453, 35856.64143358533, 31960.84019579887, 32825.83587082049, 32989.0, 33280.334393312485, 33534.49698254577, 30345.39309213759, 30805.383892322476, 30924.69075309218, 31011.0, 31016.53475197919, 31058.37883242277, 31201.219969500944, 33090.50364244587, 33696.15759606029, 33830.66169338275, 24741.381465463506, 26329.0, 26582.202533924014, 26603.733962660124, 27091.864540677172, 22412.551748965256, 24623.261302160965, 24642.876785615957, 24723.62914556319, 25104.62343064892], "unit": "score", "name": "ext.html", "value": 16602.371702187418}, {"lowerIsBetter": false, "replicates": [316.5599816255404, 319.5558174137947, 320.8524078923695, 323.35490696061345, 325.5409872080367, 12119.394030298472, 12440.564580239694, 14951.47669831556, 15167.62080947977, 15316.923415382935, 14042.94677899159, 14355.78466323006, 14421.0, 14860.182689952075, 14873.181974991372, 3886.3587508061137, 4863.29482225078, 5001.349824522807, 5010.323606313137, 5105.3873535175835, 5031.22016087507, 5067.290579318898, 5073.543381095701, 5076.796928122871, 5085.084684756743, 4897.657163998521, 5004.774785134659, 5011.373578302712, 5032.57223136032, 5056.570191533724, 4992.925106123411, 5008.774605142759, 5044.697318160922, 5046.419661738873, 5051.520105589963, 4361.563843615645, 4444.822207111712, 4450.732956022616, 4473.038296766211, 4500.122476117159, 18918.527036824053, 19190.52023699405, 19201.61596768057, 19206.90396548022, 19355.80644193554, 1815.582416044304, 1858.5632376391536, 1876.492326592885, 1908.055512521297, 1931.64264611046, 12146.635600931986, 12369.814452783216, 12370.62888113358, 12412.379381031004, 12916.612501624872, 1705.4031089118832, 1717.9914100429544, 1719.72484402495, 1726.421648747671, 1728.809830918598, 52057.21914171291, 53503.732481337734, 53628.0, 54437.72781136069, 54793.45206547963, 8938.1508756668, 8994.595243214071, 9001.459912405277, 9008.099190080939, 9075.364724469224, 9898.554565044591, 10208.928062553474, 10486.213533984981, 11150.721231969266, 11205.775884482428, 6765.9661701691175, 6808.319168083152, 6870.484713646497, 6911.067005954132, 6928.376446119873, 6775.0, 6787.2534021257625, 6837.2820853809635, 6839.897401538981, 6852.725890964306, 5357.330333708286, 5387.542058924957, 5456.836294911159, 5525.364583072998, 5599.384067752544, 1494.290212149242, 1528.0, 1542.4293011585785, 1543.7838702581648, 1555.9455419060278, 794.3803833010261, 869.3827382558328, 884.8141890203129, 930.4277869110448, 946.611889125469, 15203.61990950213, 15703.371865125268, 15954.441594544367, 16369.181540923144, 16641.66716665684, 709.3013381818904, 821.8150916043842, 839.6725277141919, 864.9610767515477, 886.5965985476593, 7955.602219889098, 8118.634661440249, 8239.423240373237, 8313.667453301921, 8365.330773538102, 482572.0, 490844.0, 492307.0, 521330.0, 527661.0, 72883.0, 74097.0, 75675.62162189154, 76235.0, 77298.0, 1054.715226888751, 1062.7715041266165, 1066.36018388966, 1086.8152414089623, 1087.8041952448477, 11847.466863991314, 13505.527306544223, 14184.290785460893, 14219.146851188962, 14433.855661443671, 24765.87617061903, 26039.869800650875, 30265.848670756506, 33976.83011585025, 34013.82993085019, 32989.90643775919, 33375.83312083521, 33390.49914251337, 33695.66304337023, 34343.82828085944, 8382.455140415854, 8473.603003959664, 8503.829923401374, 8601.870971935552, 8614.052454230155, 10032.197424206191, 10136.239782016526, 13058.281794501014, 15561.0, 15955.680886381975, 13021.934890325489, 13365.799513007118, 13447.327633618084, 13492.190468571525, 13501.189928604315, 12958.22250664963, 13116.213027218397, 13405.262710551013, 13414.731705366034, 13801.86198138046, 13268.601941941757, 13398.129121607064, 13564.728705426034, 13643.044986850826, 13919.582412527641, 8457.534835584102, 8483.98192216938, 8553.31573474133, 8585.441946273471, 8720.694775683074, 9046.63813447481, 9211.677591284273, 9223.86164207524, 12044.21712588679, 13587.184768913898], "unit": "score", "name": "jquery.html", "value": 8017.878981618303}, {"lowerIsBetter": false, "replicates": [1202.9097817663678, 1610.4363472784523, 1664.7336426171807, 1675.857552108071, 1706.0360896093707, 5782.884342313151, 6989.790306290813, 7133.215346311901, 7150.07049083619, 7153.821154471128, 7037.929620703791, 7209.495335326516, 7220.963895180516, 7232.710691572344, 7238.529495582783, 1771.5305444057335, 1798.1099355818822, 2007.0366224212387, 2009.9698504522407, 2043.6014977079476, 2107.2729908181727, 2139.732533433321, 2141.6573348264283, 2144.04589957469, 2144.5603651251536, 2014.4963759060236, 2064.205280966831, 2072.264346157115, 2072.5647614001005, 2076.0, 2040.4082815983347, 2051.0257627626906, 2069.4929742213103, 2080.240712140073, 2080.864743791649, 2136.7329083864515, 2145.8712477251415, 2151.429871084164, 2152.35429371188, 2158.3417057797524, 7005.719771209146, 7053.0830991971225, 7084.149902011792, 7084.326988936043, 7096.53872498286, 4165.770882601456, 4233.343831706091, 4263.87208383749, 4264.594863487963, 4273.594008569181, 2669.3193235724766, 2688.2607282997137, 2713.91858244253, 2718.0215122555865, 2739.7123302053196, 868.2055918834259, 873.724776695339, 877.8858748362736, 894.7136916186823, 901.2609660078738, 9609.087136722, 9675.129238368581, 9759.072888075621, 9766.36518626287, 9782.217422606174, 3908.3160446921675, 3917.5494818096286, 3947.4473573699706, 3974.1455587048345, 3974.721769476109, 8479.618417171243, 8482.787930301793, 8484.40609157353, 8494.617742201615, 8514.78713032179, 4278.507971583308, 4285.892852678646, 4302.612764851178, 4305.117450922553, 4311.461067366579, 3877.7091718121255, 3879.9612003880166, 3880.728349015542, 3891.299566078133, 3922.627350401707, 2946.6905974872757, 2978.955315670267, 3328.9001329959656, 3353.8155401453155, 3399.5750531183603, 1097.7145942054963, 1121.0695123047851, 1124.696331990358, 1133.7279053027214, 1135.8807325230896, 994.125169850527, 1095.2606990281529, 1163.790517706821, 1180.2446434282067, 1183.627157445402, 6759.493038022069, 6825.658717064127, 6827.761028363983, 6833.5216534843075, 6848.246692863781, 560.1653536230987, 574.3280361976498, 579.8927198468213, 580.5848818095083, 720.4452571520005, 5034.219695947134, 5035.420926593415, 5104.05574968632, 5112.335396398445, 5113.079645663816, 8272.751817445485, 8756.4308319959, 8777.51723655205, 8778.648854045894, 8799.912000880036, 8731.563421828883, 8732.78168045804, 8736.56317184151, 8738.69414570487, 8756.8686469703, 6761.357671021246, 6810.931890681129, 6845.5550389224545, 6922.446204303644, 6927.618980956096, 6535.640539770358, 6578.375054369827, 6584.473242140713, 6591.209054913249, 6592.868142637216, 7697.538147711155, 7977.521348719096, 7977.7207797729125, 7979.84040319202, 7990.04119505663, 7924.6037698116015, 8106.338200668731, 8223.794405139919, 8256.422050456411, 8267.255946964802, 6411.6153030818305, 6428.067930150196, 6451.70967306463, 6458.903116453163, 6518.674066296571, 5528.198411230269, 5809.5352371811, 6467.773627923, 6610.438112760469, 7033.156021277479, 6133.4786543142545, 6326.525510586816, 6362.904556431565, 6474.449671777763, 6479.157709497735, 6304.621722696653, 6446.0, 6495.220573531206, 6529.412352888263, 6554.279029306867, 6343.873122537616, 6358.268799088164, 6358.872822543616, 6365.936340636719, 6369.394907483782, 5896.115582662635, 5918.082697181943, 5928.0, 5929.525637948867, 5938.109283607493, 5925.703714814156, 6017.548683848817, 6042.939570604238, 6061.787837425669, 6107.328193898757], "unit": "score", "name": "mootools.html", "value": 4059.230390272782}, {"lowerIsBetter": false, "replicates": [293.903012006038, 296.0924765593456, 299.30411792582254, 305.2369077306733, 307.1568544345771, 5234.057869583474, 5261.947380526193, 5327.840164795062, 5354.759035843386, 5365.463453654637, 4992.201247800353, 5116.232565115234, 5142.460041695625, 5252.0, 5286.735663216833, 4052.9189416211657, 4060.1879624075154, 4063.674906007512, 4071.246819338417, 4079.4288799568085, 3909.2181563687377, 4077.3476243800997, 4077.368007958771, 4086.1419101988618, 4087.6116768906904, 3947.4868267125375, 3970.047188674712, 4053.4730485037053, 4054.776987265699, 4058.9188216235807, 4035.616616421435, 4048.5748996355255, 4051.9464939115746, 4053.391991201314, 4054.2702313583545, 3529.6293889141525, 3532.6643968822923, 3533.9293214135573, 3540.061883600848, 3550.1657110578994, 5059.848204553869, 5088.236764485357, 5102.311187989611, 5109.105906466353, 5117.309163262949, 4551.3173024046655, 4654.371659825948, 4661.510541393172, 4669.042846216517, 4669.579737823578, 5537.58468114889, 5538.778448862081, 5539.307586551681, 5540.722963851832, 5544.77820887168, 3865.439511270878, 3866.130120722843, 3866.980665096685, 3868.651821336065, 3871.5741268460447, 5817.796377126822, 5820.097884827858, 5824.980628390057, 5827.067669172912, 5829.766809327622, 3871.7676939383728, 3976.960230397659, 3979.263836190314, 3984.8007599619905, 3995.1011022520283, 4042.959570404258, 4043.8584649537124, 4043.939340909889, 4044.130511939888, 4047.817848196838, 4627.930581041287, 4628.3288923105965, 4632.2819962905805, 4634.073185362873, 4634.536546345406, 5554.527865131428, 5556.805511807148, 5557.722113894289, 5558.388577256498, 5569.610127291132, 1419.637992311954, 1427.2578259305103, 1446.9059511131743, 1456.4611093895326, 1460.7224627320775, 969.1713584884822, 971.0823272008026, 987.4618333008527, 993.2401712689798, 994.557421947241, 4887.706737595685, 4891.706497610155, 4892.584130348961, 4895.632827537949, 4897.8285759998225, 5762.481376676119, 5780.16187652788, 5786.71066446676, 5788.27646544182, 5795.797147099831, 4759.857204283877, 4816.783244753994, 4859.829905953346, 4899.191633380452, 4899.779509922062, 3103.7827352085587, 3128.906132816019, 3136.2629782001213, 3137.0902438292637, 3145.622525296979, 5447.863803404867, 5458.9454105458435, 5462.754176062087, 5473.397926228112, 5473.616846820684, 5963.0459126539545, 5968.940310596839, 5971.402859713994, 5975.4024597540765, 5976.0, 5346.4118946915805, 5489.066858633962, 5502.119660854244, 5503.532199763065, 5513.61404701667, 5784.595078344475, 5828.417158284137, 5840.445157710011, 5849.356570777296, 5854.063349864001, 5680.914786278292, 5701.8859622806485, 5703.857403564778, 5704.11586204139, 5704.1443783432815, 5320.813771517978, 5480.972595137158, 5485.451454854483, 5493.395726470165, 5504.889902202013, 3888.9805550972064, 3892.9221415572097, 3910.608939106067, 3925.7251992361403, 3933.3903244997073, 5830.446107619939, 5855.443732845373, 5855.443732845373, 5861.6189947653265, 5872.148538461985, 5653.519450846559, 5653.519450846724, 5656.943430565641, 5657.830265092054, 5659.207710920557, 5492.80775172867, 5633.6619802811965, 5641.774329026793, 5646.011947909182, 5648.971755141362, 5518.917216241679, 5529.723513824373, 5532.585056120726, 5536.114221724505, 5540.529055030368, 5674.943250567607, 5678.261825962599, 5681.346645135697, 5686.715664216856, 5688.431156884279, 5413.945860541344, 5509.063459212024, 5532.6680399176175, 5535.6955367455175, 5546.278983732089], "unit": "score", "name": "prototype.html", "value": 4182.696357379329}, {"lowerIsBetter": false, "replicates": [719.2914978745935, 736.6464097233328, 762.897008903798, 768.9423293253005, 787.3386355461412, 10784.892151078488, 11016.449177541132, 11020.669379918605, 12242.387880605978, 12540.56108036219, 13103.475860965575, 13207.207567545955, 13226.338683065856, 13226.404811783468, 13237.669058273548, 626.5989766549412, 634.1375729008568, 787.5510958753528, 804.493169303341, 805.6938363421891, 785.3677789379548, 793.6309616028545, 799.0371602219312, 799.8880156778056, 800.1478425476878, 823.5593957232882, 829.2950991657074, 835.5279267214034, 836.477201748907, 836.7029704454923, 653.555582204101, 663.2240278873729, 811.0996793559144, 821.5070957425527, 831.4013909984801, 619.6498978077371, 620.1132380695603, 620.184457438467, 620.3393386043849, 620.9099680546295, 11186.105111591054, 11253.887461125365, 11258.831117533244, 11283.097352211804, 11297.774044519147, 10485.790284194274, 10807.35155890649, 10925.508352124174, 10993.120550356032, 11261.324320540794, 9114.225290850285, 9151.65195158006, 9350.859737103949, 9409.0, 9591.808163836755, 3080.199148221456, 3084.36770462057, 3113.34619729857, 3128.4994400895976, 3219.0503801378413, 39885.80057099725, 39991.20017599632, 40300.19399611992, 40314.798426007685, 40363.7981810092, 8842.911570884338, 8914.420562663407, 8944.68693595721, 9177.724668259963, 9207.493587852732, 15988.280527376295, 16024.118673472838, 16026.0, 16042.673812297386, 16058.598535036484, 6052.364501727343, 6200.410960958701, 6200.906986395207, 6309.14826498426, 6388.169537960035, 3391.7795343302605, 3460.9480857787153, 3504.1940353718787, 3509.0700964244497, 3527.5590551181103, 2567.781738552244, 2576.0468626608276, 2598.9090381836922, 2606.830556013853, 2607.0353969031203, 441.6731618602211, 444.2669595167934, 446.32827594470115, 452.27861560810453, 454.3457421313364, 457.60188635886993, 569.257134341705, 574.2477354665401, 587.9911801322984, 597.4145337569206, 6918.619475928772, 7083.079199704005, 8305.792355191168, 8406.673318144152, 8437.156284371515, 445.97770111494947, 486.2608834571502, 514.8918727067282, 551.9751611177506, 589.3988132105229, 3369.3261347730554, 3584.677379035847, 3640.18095928414, 3675.9081022974106, 3867.1298957734284, 44841.0, 45178.32232516515, 45279.77360113178, 45781.0, 48228.5177148231, 41507.377389339184, 41820.372694409605, 41964.0, 42207.788961055616, 42746.57253427426, 37581.43627845585, 41029.79485102615, 41686.58313416827, 42196.36705449482, 43093.784531077144, 7372.741954031583, 7502.174760776201, 7777.611119444118, 7899.881501777363, 7973.162817904036, 29853.402931941673, 30173.0, 30418.84790576033, 30444.543331850484, 30890.691093088783, 37090.44364334591, 37366.62633373631, 37698.0, 38099.80950095232, 38325.4251186238, 9216.907830921873, 9496.857547136937, 9966.252531060345, 10131.63659537182, 10161.949190254298, 11294.265872718248, 11326.073793192405, 11373.488193031168, 11447.656570302905, 11589.942050289694, 9721.173700235558, 9856.802863942825, 10100.898991009995, 10289.382637041801, 10570.471476426303, 10611.0, 10755.462226888782, 10810.56757729682, 11002.50488727993, 11008.614698485515, 7607.37040824347, 9890.258230632875, 10333.0, 10667.573297068031, 10688.412137332522, 8753.693620723245, 8899.822003560022, 9218.492982886006, 9219.17027467531, 9222.354435189472, 8829.117088291376, 8899.110088991049, 8925.419847709878, 8952.68665596701, 9072.727818165466], "unit": "score", "name": "yui.html", "value": 5582.536566722605}], "name": "dromaeo_css", "value": 6238.668287061609}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 105.0, 110.0, 112.0, 112.0, 100.0, 111.0, 112.0, 119.0], "unit": "score", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [150.0, 131.0, 152.0, 169.0, 134.0, 153.0, 149.0, 129.0, 167.0, 133.0], "unit": "score", "name": "audio-beat-detection", "value": 146.7}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 160.0, 160.0, 160.0, 162.0, 161.0, 162.0, 162.0], "unit": "score", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 83.0, 95.0, 72.0, 72.0, 76.0, 98.0, 102.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 128.0, 94.0, 95.0, 95.0, 136.0, 97.0, 96.0, 135.0], "unit": "score", "name": "audio-oscillator", "value": 106.5}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.0}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 145.0, 147.0, 145.0, 146.0, 146.0, 147.0, 146.0], "unit": "score", "name": "imaging-darkroom", "value": 146.1}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [74.0, 71.0, 73.0, 72.0, 72.0, 72.0, 72.0, 82.0, 70.0, 70.0], "unit": "score", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 68.0, 67.0, 68.0, 68.0, 68.0, 70.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.9}, {"lowerIsBetter": true, "replicates": [83.0, 86.0, 84.0, 82.0, 84.0, 82.0, 84.0, 85.0, 85.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [125.0, 127.0, 119.0, 116.0, 135.0, 122.0, 123.0, 122.0, 122.0, 135.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.6}, {"lowerIsBetter": true, "replicates": [146.0, 135.0, 146.0, 147.0, 147.0, 135.0, 146.0, 146.0, 145.0, 135.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 70.0, 70.0, 70.0, 71.0, 68.0, 68.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.2}], "name": "kraken", "value": 1517.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.03021749958492], "unit": "score", "name": "Richards", "value": 212.62394600000007}, {"lowerIsBetter": false, "replicates": [186.11576400521125], "unit": "score", "name": "DeltaBlue", "value": 355.2520139999999}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5159.79381443299], "unit": "score", "name": "Decrypt", "value": 51.587526473526495}, {"lowerIsBetter": false, "replicates": [1992.03187250996], "unit": "score", "name": "RayTrace", "value": 371.474478}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [27243.243243243243], "unit": "score", "name": "RegExp", "value": 33.43893353174606}, {"lowerIsBetter": false, "replicates": [616.1429451632779], "unit": "score", "name": "Splay", "value": 132.25989299999998}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19754.54544066399}]} 08:03:48 INFO - RETURN: dromaeo_css: 6238.67 08:03:48 INFO - RETURN: kraken: 1517.40 08:03:48 INFO - RETURN: v8_7: 19754.55 08:03:48 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19754.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1517.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6238.67"}}} 08:03:48 INFO - Return code: 0 08:03:48 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 08:03:48 INFO - # TBPL SUCCESS # 08:03:48 INFO - Running post-action listener: _resource_record_post_action 08:03:48 INFO - Running post-run listener: _resource_record_post_run 08:03:49 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 553369600; Read time: 12; Write time: 583636 08:03:49 INFO - install - Wall time: 16s; CPU: 16.0%; Read bytes: 0; Write bytes: 233291776; Read time: 0; Write time: 333980 08:03:49 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 319213568; Read time: 12; Write time: 249604 08:03:49 INFO - Running post-run listener: _upload_blobber_files 08:03:49 INFO - Blob upload gear active. 08:03:49 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 08:03:49 INFO - Copying logs to upload dir... 08:03:49 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.756499 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-18 08:03:49.071849) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:03:49.075554) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.008745 build_url: 'https://queue.taskcluster.net/v1/task/hd4L16v3RlWmfPt5WSVAqA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-18 08:03:49.096800) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-12-18 08:03:49.097123) ========= 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=6e558709db315bacd2260379000001b6-1450452864.996723-1105665772 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004602 ========= master_lag: 2.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 2 secs) (at 2015-12-18 08:03:51.540346) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:03:51.540686) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-18 08:03:51.541407) ========= ========= Total master_lag: 2.63 =========