builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-056 starttime: 1447813385.56 results: success (0) buildid: 20151117175934 builduid: 155f2bed055746e5be96a8a2c196f355 revision: 4e0a66f7b693d055ef52c5b17d55cb117d6296b0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.556746) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.557144) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.557437) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.007988 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.619746) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.620019) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.721170) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.721421) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027400 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.775979) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.776265) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.776654) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:05.776947) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 18:23:06-- 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% 225M=0s 2015-11-17 18:23:06 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232637 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.024080) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.024361) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.167316 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.204213) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.204948) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4e0a66f7b693d055ef52c5b17d55cb117d6296b0 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 4e0a66f7b693d055ef52c5b17d55cb117d6296b0 --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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 18:23:06,458 truncating revision to first 12 chars 2015-11-17 18:23:06,458 Setting DEBUG logging. 2015-11-17 18:23:06,458 attempt 1/10 2015-11-17 18:23:06,458 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/4e0a66f7b693?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 18:23:06,697 unpacking tar archive at: mozilla-inbound-4e0a66f7b693/testing/mozharness/ program finished with exit code 0 elapsedTime=0.516480 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.733039) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.733308) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.739636) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.739919) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 18:23:06.740306) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-17 18:23:06.740594) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Inbound-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 18:23:07 INFO - MultiFileLogger online at 20151117 18:23:07 in /builds/slave/test 18:23:07 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 18:23:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:23:07 INFO - {'append_to_log': False, 18:23:07 INFO - 'base_work_dir': '/builds/slave/test', 18:23:07 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 18:23:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:23:07 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 18:23:07 INFO - 'buildbot_json_path': 'buildprops.json', 18:23:07 INFO - 'config_files': ('talos/linux_config.py',), 18:23:07 INFO - 'default_actions': ('clobber', 18:23:07 INFO - 'read-buildbot-config', 18:23:07 INFO - 'download-and-extract', 18:23:07 INFO - 'populate-webroot', 18:23:07 INFO - 'create-virtualenv', 18:23:07 INFO - 'install', 18:23:07 INFO - 'run-tests'), 18:23:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:23:07 INFO - 'download_minidump_stackwalk': True, 18:23:07 INFO - 'download_symbols': 'ondemand', 18:23:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:23:07 INFO - 'tooltool.py': '/tools/tooltool.py', 18:23:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:23:07 INFO - '/tools/misc-python/virtualenv.py')}, 18:23:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:23:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:23:07 INFO - 'installer_path': 'installer.exe', 18:23:07 INFO - 'log_level': 'info', 18:23:07 INFO - 'log_name': 'talos', 18:23:07 INFO - 'log_to_console': True, 18:23:07 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 18:23:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 18:23:07 INFO - 'opt_config_files': (), 18:23:07 INFO - 'pip_index': False, 18:23:07 INFO - 'sps_profile': False, 18:23:07 INFO - 'sps_profile_interval': 0, 18:23:07 INFO - 'suite': 'dromaeojs', 18:23:07 INFO - 'system_bits': '64', 18:23:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:23:07 INFO - 'title': 'talos-linux64-ix-056', 18:23:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:23:07 INFO - 'use_talos_json': True, 18:23:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:23:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:23:07 INFO - 'work_dir': 'build'} 18:23:07 INFO - ##### 18:23:07 INFO - ##### Running clobber step. 18:23:07 INFO - ##### 18:23:07 INFO - Running pre-action listener: _resource_record_pre_action 18:23:07 INFO - Running main action method: clobber 18:23:07 INFO - rmtree: /builds/slave/test/build 18:23:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:23:08 INFO - Running post-action listener: _resource_record_post_action 18:23:08 INFO - ##### 18:23:08 INFO - ##### Running read-buildbot-config step. 18:23:08 INFO - ##### 18:23:08 INFO - Running pre-action listener: _resource_record_pre_action 18:23:08 INFO - Running main action method: read_buildbot_config 18:23:08 INFO - Using buildbot properties: 18:23:08 INFO - { 18:23:08 INFO - "properties": { 18:23:08 INFO - "buildnumber": 2581, 18:23:08 INFO - "product": "firefox", 18:23:08 INFO - "script_repo_revision": "production", 18:23:08 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 18:23:08 INFO - "repository": "", 18:23:08 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 18:23:08 INFO - "buildid": "20151117175934", 18:23:08 INFO - "slavename": "talos-linux64-ix-056", 18:23:08 INFO - "pgo_build": "False", 18:23:08 INFO - "basedir": "/builds/slave/test", 18:23:08 INFO - "project": "", 18:23:08 INFO - "platform": "ubuntu64_hw", 18:23:08 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 18:23:08 INFO - "slavebuilddir": "test", 18:23:08 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 18:23:08 INFO - "branch": "mozilla-inbound", 18:23:08 INFO - "repo_path": "integration/mozilla-inbound", 18:23:08 INFO - "stage_platform": "linux64", 18:23:08 INFO - "builduid": "155f2bed055746e5be96a8a2c196f355", 18:23:08 INFO - "revision": "4e0a66f7b693d055ef52c5b17d55cb117d6296b0" 18:23:08 INFO - }, 18:23:08 INFO - "sourcestamp": { 18:23:08 INFO - "repository": "", 18:23:08 INFO - "hasPatch": false, 18:23:08 INFO - "project": "", 18:23:08 INFO - "branch": "mozilla-inbound-linux64-talos", 18:23:08 INFO - "changes": [ 18:23:08 INFO - { 18:23:08 INFO - "category": null, 18:23:08 INFO - "files": [ 18:23:08 INFO - { 18:23:08 INFO - "url": null, 18:23:08 INFO - "name": "https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 18:23:08 INFO - } 18:23:08 INFO - ], 18:23:08 INFO - "repository": "", 18:23:08 INFO - "rev": "4e0a66f7b693d055ef52c5b17d55cb117d6296b0", 18:23:08 INFO - "who": "nnethercote@mozilla.com", 18:23:08 INFO - "when": 1447813300, 18:23:08 INFO - "number": 6675396, 18:23:08 INFO - "comments": "Bug 1186787 (part 2) - Replace nsBaseHashtable::EnumerateRead() calls in chrome/ with iterators. r=froydnj.", 18:23:08 INFO - "project": "", 18:23:08 INFO - "at": "Tue 17 Nov 2015 18:21:40", 18:23:08 INFO - "branch": "mozilla-inbound-linux64-talos", 18:23:08 INFO - "revlink": "", 18:23:08 INFO - "properties": [ 18:23:08 INFO - [ 18:23:08 INFO - "buildid", 18:23:08 INFO - "20151117175934", 18:23:08 INFO - "Change" 18:23:08 INFO - ], 18:23:08 INFO - [ 18:23:08 INFO - "builduid", 18:23:08 INFO - "155f2bed055746e5be96a8a2c196f355", 18:23:08 INFO - "Change" 18:23:08 INFO - ], 18:23:08 INFO - [ 18:23:08 INFO - "pgo_build", 18:23:08 INFO - "False", 18:23:08 INFO - "Change" 18:23:08 INFO - ] 18:23:08 INFO - ], 18:23:08 INFO - "revision": "4e0a66f7b693d055ef52c5b17d55cb117d6296b0" 18:23:08 INFO - } 18:23:08 INFO - ], 18:23:08 INFO - "revision": "4e0a66f7b693d055ef52c5b17d55cb117d6296b0" 18:23:08 INFO - } 18:23:08 INFO - } 18:23:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 18:23:08 INFO - Running post-action listener: _resource_record_post_action 18:23:08 INFO - ##### 18:23:08 INFO - ##### Running download-and-extract step. 18:23:08 INFO - ##### 18:23:08 INFO - Running pre-action listener: _resource_record_pre_action 18:23:08 INFO - Running main action method: download_and_extract 18:23:08 INFO - mkdir: /builds/slave/test/build/tests 18:23: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')]} 18:23:08 INFO - https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:23:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/test_packages.json 18:23:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/test_packages.json 18:23:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:23:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:23:10 INFO - Downloaded 1302 bytes. 18:23:10 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:23:10 INFO - Using the following test package requirements: 18:23:10 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:10 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 18:23:10 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'jsshell-linux-x86_64.zip'], 18:23:10 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 18:23:10 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:10 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 18:23:10 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 18:23:10 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 18:23:10 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 18:23:10 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 18:23:10 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 18:23:10 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 18:23:10 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')]} 18:23:10 INFO - https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:23:11 INFO - Downloaded 21277464 bytes. 18:23:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:23:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:23:12 INFO - Return code: 0 18:23:12 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 18:23:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:12 INFO - https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 18:23:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 18:23:17 INFO - Downloaded 21277464 bytes. 18:23:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 18:23:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 18:23:18 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 18:23:19 INFO - Return code: 0 18:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:19 INFO - https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 18:23:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 18:23:20 INFO - Downloaded 11130997 bytes. 18:23:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 18:23:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 18:23:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 18:23:20 INFO - Return code: 0 18:23:20 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')]} 18:23:20 INFO - https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 18:23:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:23:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:23:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:23:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 18:23:21 INFO - Downloaded 55655293 bytes. 18:23:21 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:23:21 INFO - mkdir: /builds/slave/test/properties 18:23:21 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:23:21 INFO - Writing to file /builds/slave/test/properties/build_url 18:23:21 INFO - Contents: 18:23:21 INFO - build_url:https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 18:23:21 INFO - Running post-action listener: _resource_record_post_action 18:23:21 INFO - Running post-action listener: set_extra_try_arguments 18:23:21 INFO - ##### 18:23:21 INFO - ##### Running populate-webroot step. 18:23:21 INFO - ##### 18:23:21 INFO - Running pre-action listener: _resource_record_pre_action 18:23:21 INFO - Running main action method: populate_webroot 18:23:21 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:23:21 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:23:21 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:23:21 INFO - '../fennec_ids.txt'], 18:23:21 INFO - 'tests': ['tcheck2']}, 18:23:21 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:23:21 INFO - '--tppagecycles', 18:23:21 INFO - '7'], 18:23:21 INFO - 'tests': ['tsvgm']}}, 18:23:21 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:23:21 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:23:21 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:23:21 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:23:21 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:21 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:23:21 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['damp', 'tps']}, 18:23:21 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['damp', 'tps']}, 18:23:21 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:23:21 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:23:21 INFO - 'other': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other_l64': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'other_nol64': {'tests': ['a11yr', 18:23:21 INFO - 'ts_paint', 18:23:21 INFO - 'tpaint', 18:23:21 INFO - 'sessionrestore', 18:23:21 INFO - 'sessionrestore_no_auto_restore']}, 18:23:21 INFO - 'svgr': {'tests': ['tsvgx', 18:23:21 INFO - 'tsvgr_opacity', 18:23:21 INFO - 'tart', 18:23:21 INFO - 'tscrollx', 18:23:21 INFO - 'cart']}, 18:23:21 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tsvgx', 18:23:21 INFO - 'tsvgr_opacity', 18:23:21 INFO - 'tart', 18:23:21 INFO - 'tscrollx', 18:23:21 INFO - 'cart']}, 18:23:21 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'tests': ['tp5o']}, 18:23:21 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s'], 18:23:21 INFO - 'tests': ['tp5o']}, 18:23:21 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--xperf_path', 18:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:21 INFO - 'tests': ['tp5n']}, 18:23:21 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:23:21 INFO - 'talos_options': ['--e10s', 18:23:21 INFO - '--xperf_path', 18:23:21 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:23:21 INFO - 'tests': ['tp5n']}}, 18:23:21 INFO - 'talos.zip': {'path': '', 18:23:21 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:23:21 INFO - Running post-action listener: _resource_record_post_action 18:23:21 INFO - ##### 18:23:21 INFO - ##### Running create-virtualenv step. 18:23:21 INFO - ##### 18:23:21 INFO - Running pre-action listener: _resource_record_pre_action 18:23:21 INFO - Running main action method: create_virtualenv 18:23:21 INFO - Creating virtualenv /builds/slave/test/build/venv 18:23:21 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 18:23:21 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:23:21 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:23:21 INFO - Using real prefix '/usr' 18:23:21 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:23:22 INFO - Installing distribute.............................................................................................................................................................................................done. 18:23:26 INFO - Installing pip.................done. 18:23:26 INFO - Return code: 0 18:23:26 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:26 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:26 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 18:23:26 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 18:23:26 INFO - Using env: {'DISPLAY': ':0', 18:23:26 INFO - 'HOME': '/home/cltbld', 18:23:26 INFO - 'LANG': 'en_US.UTF-8', 18:23:26 INFO - 'LANGUAGE': 'en_US:en', 18:23:26 INFO - 'LOGNAME': 'cltbld', 18:23:26 INFO - 'MAIL': '/var/mail/cltbld', 18:23:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:26 INFO - 'MOZ_NO_REMOTE': '1', 18:23:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:26 INFO - 'NO_EM_RESTART': '1', 18:23:26 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:26 INFO - 'PWD': '/builds/slave/test', 18:23:26 INFO - 'SHELL': '/bin/bash', 18:23:26 INFO - 'SHLVL': '1', 18:23:26 INFO - 'TERM': 'linux', 18:23:26 INFO - 'TMOUT': '86400', 18:23:26 INFO - 'USER': 'cltbld', 18:23:26 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:26 INFO - '_': '/tools/buildbot/bin/python'} 18:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:28 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 18:23:28 INFO - Cleaning up... 18:23:28 INFO - Return code: 0 18:23:28 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:23:28 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')]} 18:23:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:28 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')]} 18:23:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:28 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:28 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 18:23:28 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 18:23:28 INFO - Using env: {'DISPLAY': ':0', 18:23:28 INFO - 'HOME': '/home/cltbld', 18:23:28 INFO - 'LANG': 'en_US.UTF-8', 18:23:28 INFO - 'LANGUAGE': 'en_US:en', 18:23:28 INFO - 'LOGNAME': 'cltbld', 18:23:28 INFO - 'MAIL': '/var/mail/cltbld', 18:23:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:28 INFO - 'MOZ_NO_REMOTE': '1', 18:23:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:28 INFO - 'NO_EM_RESTART': '1', 18:23:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:28 INFO - 'PWD': '/builds/slave/test', 18:23:28 INFO - 'SHELL': '/bin/bash', 18:23:28 INFO - 'SHLVL': '1', 18:23:28 INFO - 'TERM': 'linux', 18:23:28 INFO - 'TMOUT': '86400', 18:23:28 INFO - 'USER': 'cltbld', 18:23:28 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:28 INFO - '_': '/tools/buildbot/bin/python'} 18:23:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:28 INFO - Downloading/unpacking psutil>=0.7.1 18:23:28 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 18:23:28 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 18:23:28 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 18:23:28 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 18:23:28 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 18:23:28 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 18:23:30 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:23:30 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:23:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:23:30 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:30 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:30 INFO - Installing collected packages: psutil 18:23:30 INFO - Running setup.py install for psutil 18:23:30 INFO - building 'psutil._psutil_linux' extension 18:23:30 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 18:23:32 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 18:23:32 INFO - building 'psutil._psutil_posix' extension 18:23:32 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 18:23:32 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 18:23:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:23:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:23:32 INFO - Successfully installed psutil 18:23:32 INFO - Cleaning up... 18:23:32 INFO - Return code: 0 18:23:32 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:23:32 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')]} 18:23:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:32 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')]} 18:23:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:32 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:32 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 18:23:32 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 18:23:32 INFO - Using env: {'DISPLAY': ':0', 18:23:32 INFO - 'HOME': '/home/cltbld', 18:23:32 INFO - 'LANG': 'en_US.UTF-8', 18:23:32 INFO - 'LANGUAGE': 'en_US:en', 18:23:32 INFO - 'LOGNAME': 'cltbld', 18:23:32 INFO - 'MAIL': '/var/mail/cltbld', 18:23:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:32 INFO - 'MOZ_NO_REMOTE': '1', 18:23:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:32 INFO - 'NO_EM_RESTART': '1', 18:23:32 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:32 INFO - 'PWD': '/builds/slave/test', 18:23:32 INFO - 'SHELL': '/bin/bash', 18:23:32 INFO - 'SHLVL': '1', 18:23:32 INFO - 'TERM': 'linux', 18:23:32 INFO - 'TMOUT': '86400', 18:23:32 INFO - 'USER': 'cltbld', 18:23:32 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:32 INFO - '_': '/tools/buildbot/bin/python'} 18:23:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:32 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:23:32 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 18:23:32 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 18:23:32 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 18:23:32 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 18:23:32 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 18:23:32 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 18:23:34 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:23:34 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:23:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:23:34 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:23:34 INFO - Installing collected packages: mozsystemmonitor 18:23:34 INFO - Running setup.py install for mozsystemmonitor 18:23:34 INFO - Successfully installed mozsystemmonitor 18:23:34 INFO - Cleaning up... 18:23:34 INFO - Return code: 0 18:23:34 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:34 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:34 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 18:23:34 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 18:23:34 INFO - Using env: {'DISPLAY': ':0', 18:23:34 INFO - 'HOME': '/home/cltbld', 18:23:34 INFO - 'LANG': 'en_US.UTF-8', 18:23:34 INFO - 'LANGUAGE': 'en_US:en', 18:23:34 INFO - 'LOGNAME': 'cltbld', 18:23:34 INFO - 'MAIL': '/var/mail/cltbld', 18:23:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:34 INFO - 'MOZ_NO_REMOTE': '1', 18:23:34 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:34 INFO - 'NO_EM_RESTART': '1', 18:23:34 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:34 INFO - 'PWD': '/builds/slave/test', 18:23:34 INFO - 'SHELL': '/bin/bash', 18:23:34 INFO - 'SHLVL': '1', 18:23:34 INFO - 'TERM': 'linux', 18:23:34 INFO - 'TMOUT': '86400', 18:23:34 INFO - 'USER': 'cltbld', 18:23:34 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:34 INFO - '_': '/tools/buildbot/bin/python'} 18:23:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:34 INFO - Downloading/unpacking blobuploader==1.2.4 18:23:34 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 18:23:34 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 18:23:34 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 18:23:34 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 18:23:34 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 18:23:34 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 18:23:36 INFO - Downloading blobuploader-1.2.4.tar.gz 18:23:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:23:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:23:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:23:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:36 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 18:23:37 INFO - Downloading docopt-0.6.1.tar.gz 18:23:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:23:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:23:37 INFO - Installing collected packages: blobuploader, requests, docopt 18:23:37 INFO - Running setup.py install for blobuploader 18:23:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:23:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:23:37 INFO - Running setup.py install for requests 18:23:37 INFO - Running setup.py install for docopt 18:23:37 INFO - Successfully installed blobuploader requests docopt 18:23:37 INFO - Cleaning up... 18:23:37 INFO - Return code: 0 18:23:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:37 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:37 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 18:23:37 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 18:23:37 INFO - Using env: {'DISPLAY': ':0', 18:23:37 INFO - 'HOME': '/home/cltbld', 18:23:37 INFO - 'LANG': 'en_US.UTF-8', 18:23:37 INFO - 'LANGUAGE': 'en_US:en', 18:23:37 INFO - 'LOGNAME': 'cltbld', 18:23:37 INFO - 'MAIL': '/var/mail/cltbld', 18:23:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:37 INFO - 'MOZ_NO_REMOTE': '1', 18:23:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:37 INFO - 'NO_EM_RESTART': '1', 18:23:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:37 INFO - 'PWD': '/builds/slave/test', 18:23:37 INFO - 'SHELL': '/bin/bash', 18:23:37 INFO - 'SHLVL': '1', 18:23:37 INFO - 'TERM': 'linux', 18:23:37 INFO - 'TMOUT': '86400', 18:23:37 INFO - 'USER': 'cltbld', 18:23:37 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:37 INFO - '_': '/tools/buildbot/bin/python'} 18:23:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:37 INFO - Running setup.py (path:/tmp/pip-rjvta3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:38 INFO - Running setup.py (path:/tmp/pip-TmrAVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:38 INFO - Running setup.py (path:/tmp/pip-M2hMDK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:38 INFO - Running setup.py (path:/tmp/pip-L7xZ95-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:38 INFO - Running setup.py (path:/tmp/pip-ML4ASS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:38 INFO - Running setup.py (path:/tmp/pip-aALB5Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:38 INFO - Running setup.py (path:/tmp/pip-lGkZ2g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:38 INFO - Running setup.py (path:/tmp/pip-mIIjCP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:38 INFO - Running setup.py (path:/tmp/pip-4FnZoH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:38 INFO - Running setup.py (path:/tmp/pip-KCHExX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:38 INFO - Running setup.py (path:/tmp/pip-jL2GRk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:38 INFO - Running setup.py (path:/tmp/pip-1KpoAu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:38 INFO - Running setup.py (path:/tmp/pip-VPLRx0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:38 INFO - Running setup.py (path:/tmp/pip-Gs91wb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:38 INFO - Running setup.py (path:/tmp/pip-f8gLe6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:39 INFO - Running setup.py (path:/tmp/pip-f2RRsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:39 INFO - Running setup.py (path:/tmp/pip-dmYKWe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:39 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:23:39 INFO - Running setup.py install for manifestparser 18:23:39 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Running setup.py install for mozcrash 18:23:39 INFO - Running setup.py install for mozdebug 18:23:39 INFO - Running setup.py install for mozdevice 18:23:39 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Running setup.py install for mozfile 18:23:39 INFO - Running setup.py install for mozhttpd 18:23:39 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Running setup.py install for mozinfo 18:23:39 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:23:39 INFO - Running setup.py install for mozInstall 18:23:40 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozleak 18:23:40 INFO - Running setup.py install for mozlog 18:23:40 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for moznetwork 18:23:40 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozprocess 18:23:40 INFO - Running setup.py install for mozprofile 18:23:40 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozrunner 18:23:40 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Running setup.py install for mozscreenshot 18:23:40 INFO - Running setup.py install for moztest 18:23:40 INFO - Running setup.py install for mozversion 18:23:40 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:23:40 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:23:40 INFO - Cleaning up... 18:23:40 INFO - Return code: 0 18:23:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:40 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:40 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 18:23:40 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 18:23:40 INFO - Using env: {'DISPLAY': ':0', 18:23:40 INFO - 'HOME': '/home/cltbld', 18:23:40 INFO - 'LANG': 'en_US.UTF-8', 18:23:40 INFO - 'LANGUAGE': 'en_US:en', 18:23:40 INFO - 'LOGNAME': 'cltbld', 18:23:40 INFO - 'MAIL': '/var/mail/cltbld', 18:23:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:40 INFO - 'MOZ_NO_REMOTE': '1', 18:23:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:40 INFO - 'NO_EM_RESTART': '1', 18:23:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:40 INFO - 'PWD': '/builds/slave/test', 18:23:40 INFO - 'SHELL': '/bin/bash', 18:23:40 INFO - 'SHLVL': '1', 18:23:40 INFO - 'TERM': 'linux', 18:23:40 INFO - 'TMOUT': '86400', 18:23:40 INFO - 'USER': 'cltbld', 18:23:40 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:40 INFO - '_': '/tools/buildbot/bin/python'} 18:23:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:23:41 INFO - Running setup.py (path:/tmp/pip-9Ytv96-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:23:41 INFO - Running setup.py (path:/tmp/pip-q7cO65-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:23:41 INFO - Running setup.py (path:/tmp/pip-FGwENo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:23:41 INFO - Running setup.py (path:/tmp/pip-fchjR9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:23:41 INFO - Running setup.py (path:/tmp/pip-zOs76k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:23:41 INFO - Running setup.py (path:/tmp/pip-mCcT0J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:23:41 INFO - Running setup.py (path:/tmp/pip-t0krLj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:23:41 INFO - Running setup.py (path:/tmp/pip-BmRDOr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:23:41 INFO - Running setup.py (path:/tmp/pip-KkaQHC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:23:41 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:23:41 INFO - Running setup.py (path:/tmp/pip-RXSvbu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:23:41 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 18:23:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:23:41 INFO - Running setup.py (path:/tmp/pip-PTZyYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:23:42 INFO - Running setup.py (path:/tmp/pip-jLw0pj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:23:42 INFO - Running setup.py (path:/tmp/pip-CMI0ij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:23:42 INFO - Running setup.py (path:/tmp/pip-gFPftg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:42 INFO - Running setup.py (path:/tmp/pip-pg40AY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:23:42 INFO - Running setup.py (path:/tmp/pip-7d4kxp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:23:42 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)) 18:23:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:23:42 INFO - Running setup.py (path:/tmp/pip-O0yMLO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:23:42 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)) 18:23:42 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)) 18:23:42 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)) 18:23:42 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)) 18:23:42 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)) 18:23:42 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)) 18:23:42 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:23:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:23:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:23:44 INFO - Downloading blessings-1.5.1.tar.gz 18:23:44 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 18:23:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:23:44 INFO - Installing collected packages: blessings 18:23:44 INFO - Running setup.py install for blessings 18:23:44 INFO - Successfully installed blessings 18:23:44 INFO - Cleaning up... 18:23:44 INFO - Return code: 0 18:23:44 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:44 INFO - Reading from file tmpfile_stdout 18:23:44 INFO - Current package versions: 18:23:44 INFO - argparse == 1.2.1 18:23:44 INFO - blessings == 1.5.1 18:23:44 INFO - blobuploader == 1.2.4 18:23:44 INFO - docopt == 0.6.1 18:23:44 INFO - manifestparser == 1.1 18:23:44 INFO - mozInstall == 1.12 18:23:44 INFO - mozcrash == 0.16 18:23:44 INFO - mozdebug == 0.1 18:23:44 INFO - mozdevice == 0.47 18:23:44 INFO - mozfile == 1.2 18:23:44 INFO - mozhttpd == 0.7 18:23:44 INFO - mozinfo == 0.9 18:23:44 INFO - mozleak == 0.1 18:23:44 INFO - mozlog == 3.0 18:23:44 INFO - moznetwork == 0.27 18:23:44 INFO - mozprocess == 0.22 18:23:44 INFO - mozprofile == 0.27 18:23:44 INFO - mozrunner == 6.11 18:23:44 INFO - mozscreenshot == 0.1 18:23:44 INFO - mozsystemmonitor == 0.0 18:23:44 INFO - moztest == 0.7 18:23:44 INFO - mozversion == 1.4 18:23:44 INFO - psutil == 3.1.1 18:23:44 INFO - requests == 1.2.3 18:23:44 INFO - wsgiref == 0.1.2 18:23:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:23:44 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')]} 18:23:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:23:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:44 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')]} 18:23:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:23:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:23:44 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 0x7f0226c87c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1726900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, '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': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', '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 18:23:44 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 18:23:44 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 18:23:44 INFO - Using env: {'DISPLAY': ':0', 18:23:44 INFO - 'HOME': '/home/cltbld', 18:23:44 INFO - 'LANG': 'en_US.UTF-8', 18:23:44 INFO - 'LANGUAGE': 'en_US:en', 18:23:44 INFO - 'LOGNAME': 'cltbld', 18:23:44 INFO - 'MAIL': '/var/mail/cltbld', 18:23:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:44 INFO - 'MOZ_NO_REMOTE': '1', 18:23:44 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:44 INFO - 'NO_EM_RESTART': '1', 18:23:44 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:44 INFO - 'PWD': '/builds/slave/test', 18:23:44 INFO - 'SHELL': '/bin/bash', 18:23:44 INFO - 'SHLVL': '1', 18:23:44 INFO - 'TERM': 'linux', 18:23:44 INFO - 'TMOUT': '86400', 18:23:44 INFO - 'USER': 'cltbld', 18:23:44 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:44 INFO - '_': '/tools/buildbot/bin/python'} 18:23:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 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)) 18:23:44 INFO - Cleaning up... 18:23:44 INFO - Return code: 0 18:23:44 INFO - Running post-action listener: _resource_record_post_action 18:23:44 INFO - Running post-action listener: _start_resource_monitoring 18:23:44 INFO - Starting resource monitoring. 18:23:44 INFO - ##### 18:23:44 INFO - ##### Running install step. 18:23:44 INFO - ##### 18:23:44 INFO - Running pre-action listener: _resource_record_pre_action 18:23:44 INFO - Running main action method: install 18:23:44 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:23:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:23:45 INFO - Reading from file tmpfile_stdout 18:23:45 INFO - Detecting whether we're running mozinstall >=1.0... 18:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:23:45 INFO - Reading from file tmpfile_stdout 18:23:45 INFO - Output received: 18:23:45 INFO - Usage: mozinstall [options] installer 18:23:45 INFO - Options: 18:23:45 INFO - -h, --help show this help message and exit 18:23:45 INFO - -d DEST, --destination=DEST 18:23:45 INFO - Directory to install application into. [default: 18:23:45 INFO - "/builds/slave/test"] 18:23:45 INFO - --app=APP Application being installed. [default: firefox] 18:23:45 INFO - mkdir: /builds/slave/test/build/application 18:23:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 18:23:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 18:23:59 INFO - Reading from file tmpfile_stdout 18:23:59 INFO - Output received: 18:23:59 INFO - /builds/slave/test/build/application/firefox/firefox 18:23:59 INFO - Running post-action listener: _resource_record_post_action 18:23:59 INFO - ##### 18:23:59 INFO - ##### Running run-tests step. 18:23:59 INFO - ##### 18:23:59 INFO - Running pre-action listener: _resource_record_pre_action 18:23:59 INFO - Running main action method: run_tests 18:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:23:59 INFO - Python 2.7.3 18:23:59 INFO - Return code: 0 18:23:59 INFO - grabbing minidump binary from tooltool 18:23:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:23:59 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 0x176cb70>, '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 0x17bddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17be250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:23:59 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 18:23:59 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 18:23:59 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:23:59 INFO - Return code: 0 18:23:59 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 18:23:59 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:23:59 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:23:59 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 18:23:59 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:23:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] in /builds/slave/test/build 18:23:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-056 --webServer localhost 18:23:59 INFO - Using env: {'DISPLAY': ':0', 18:23:59 INFO - 'HOME': '/home/cltbld', 18:23:59 INFO - 'LANG': 'en_US.UTF-8', 18:23:59 INFO - 'LANGUAGE': 'en_US:en', 18:23:59 INFO - 'LOGNAME': 'cltbld', 18:23:59 INFO - 'MAIL': '/var/mail/cltbld', 18:23:59 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:23:59 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 18:23:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:23:59 INFO - 'MOZ_NO_REMOTE': '1', 18:23:59 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:23:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 18:23:59 INFO - 'NO_EM_RESTART': '1', 18:23:59 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 18:23:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:23:59 INFO - 'PWD': '/builds/slave/test', 18:23:59 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:23:59 INFO - 'SHELL': '/bin/bash', 18:23:59 INFO - 'SHLVL': '1', 18:23:59 INFO - 'TERM': 'linux', 18:23:59 INFO - 'TMOUT': '86400', 18:23:59 INFO - 'USER': 'cltbld', 18:23:59 INFO - 'XDG_SESSION_COOKIE': '0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719', 18:23:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:23:59 INFO - '_': '/tools/buildbot/bin/python'} 18:23:59 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-056', '--webServer', 'localhost'] with output_timeout 3600 18:23:59 INFO - mozversion INFO | application_buildid: 20151117175934 18:23:59 INFO - mozversion INFO | application_changeset: 4e0a66f7b693d055ef52c5b17d55cb117d6296b0 18:23:59 INFO - mozversion INFO | application_display_name: Nightly 18:23:59 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:23:59 INFO - mozversion INFO | application_name: Firefox 18:23:59 INFO - mozversion INFO | application_remotingname: firefox 18:23:59 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:23:59 INFO - mozversion INFO | application_vendor: Mozilla 18:23:59 INFO - mozversion INFO | application_version: 45.0a1 18:23:59 INFO - mozversion INFO | platform_buildid: 20151117175934 18:23:59 INFO - mozversion INFO | platform_changeset: 4e0a66f7b693d055ef52c5b17d55cb117d6296b0 18:23:59 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 18:23:59 INFO - mozversion INFO | platform_version: 45.0a1 18:23:59 INFO - 2015-11-17 18:23:59,561 DEBUG : using testdate: 1447813439 18:23:59 INFO - 2015-11-17 18:23:59,561 DEBUG : actual date: 1447813439 18:23:59 INFO - 2015-11-17 18:23:59,569 INFO : starting webserver on 'localhost:44008' 18:23:59 INFO - 2015-11-17 18:23:59,570 INFO : Starting test suite talos-linux64-ix-056 18:23:59 INFO - 2015-11-17 18:23:59,570 INFO : Starting test dromaeo_css 18:23:59 INFO - 2015-11-17 18:23:59,570 DEBUG : operating with platform_type : linux_ 18:23:59 INFO - 2015-11-17 18:23:59,570 INFO : Initialising browser for dromaeo_css test... 18:23:59 INFO - 2015-11-17 18:23:59,584 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7fY5I/profile http://localhost:44008/getInfo.html 18:24:07 INFO - 2015-11-17 18:24:07,108 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:24:07 INFO - 2015-11-17 18:24:07,108 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:24:07 INFO - 2015-11-17 18:24:07,108 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:24:07 INFO - 2015-11-17 18:24:07,108 DEBUG : BROWSER_OUTPUT: __metrics 18:24:07 INFO - 2015-11-17 18:24:07,257 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:24:08 INFO - 2015-11-17 18:24:08,555 INFO : Browser initialized. 18:24:08 INFO - 2015-11-17 18:24:08,555 INFO : Running cycle 1/1 for dromaeo_css test... 18:24:08 INFO - 2015-11-17 18:24:08,555 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpe7fY5I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:24:20 INFO - 2015-11-17 18:24:20,561 DEBUG : BROWSER_OUTPUT: RSS: Main: 139837440 18:24:20 INFO - 2015-11-17 18:24:20,561 DEBUG : BROWSER_OUTPUT: 18:25:11 INFO - 2015-11-17 18:25:11,908 DEBUG : BROWSER_OUTPUT: 1447813511907 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] 18:27:24 INFO - 2015-11-17 18:27:24,123 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-dojo.html (next: http://localhost:44008/tests/dromaeo/cssquery-ext.html) 18:27:25 INFO - 2015-11-17 18:27:25,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 233259008 18:27:25 INFO - 2015-11-17 18:27:25,234 DEBUG : BROWSER_OUTPUT: 18:30:27 INFO - 2015-11-17 18:30:27,982 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-ext.html (next: http://localhost:44008/tests/dromaeo/cssquery-jquery.html) 18:30:28 INFO - 2015-11-17 18:30:28,551 DEBUG : BROWSER_OUTPUT: RSS: Main: 222498816 18:30:28 INFO - 2015-11-17 18:30:28,551 DEBUG : BROWSER_OUTPUT: 18:33:30 INFO - 2015-11-17 18:33:30,587 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-jquery.html (next: http://localhost:44008/tests/dromaeo/cssquery-mootools.html) 18:33:31 INFO - 2015-11-17 18:33:31,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 215281664 18:33:31 INFO - 2015-11-17 18:33:31,160 DEBUG : BROWSER_OUTPUT: 18:36:33 INFO - 2015-11-17 18:36:33,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-mootools.html (next: http://localhost:44008/tests/dromaeo/cssquery-prototype.html) 18:36:33 INFO - 2015-11-17 18:36:33,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 203874304 18:36:33 INFO - 2015-11-17 18:36:33,681 DEBUG : BROWSER_OUTPUT: 18:39:36 INFO - 2015-11-17 18:39:36,286 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-prototype.html (next: http://localhost:44008/tests/dromaeo/cssquery-yui.html) 18:39:36 INFO - 2015-11-17 18:39:36,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 207683584 18:39:36 INFO - 2015-11-17 18:39:36,867 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/dromaeo/cssquery-yui.html (next: http://localhost:44008/tests/dromaeo/cssquery-dojo.html) 18:42:39 INFO - 2015-11-17 18:42:39,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 253902848 18:42:39 INFO - 2015-11-17 18:42:39,684 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,684 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:42:39 INFO - 2015-11-17 18:42:39,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:42:39 INFO - 2015-11-17 18:42:39,685 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:42:39 INFO - 2015-11-17 18:42:39,685 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:42:39 INFO - 2015-11-17 18:42:39,685 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2582.7933765298776;2665.307020174754;2713.945721085577;2734.890604375825;2751.8761655725502;4392.099619577987;4524.479684836245;4618.076384723056;4720.69315494493;4721.339012538238;4622.907541849161;4658.90682186356;4684.297355396692;4731.124741922738;4755.976220118903;4286.442762440878;4326.6538676905775;4334;4457.39825123609;4549.203889319372;4357.346398040288;4448.933266001012;4453.087117140978;4468.463784345883;4501.707389019703;4126.48418947633;4134.772587507686;4233.491980962273;4261.552536983603;4332.588404101605;4402.713823601455;4407.405000324947;4416.447944006999;4426.867193984153;4462.598366147063;4392.3191905254735;4415.161119387306;4419.138268037702;4439.622632076277;4454.844080457168;4482.663800214964;4600.654950878664;4604.5165257647795;4643.837465688718;4751.596114330286;5171.741412929338;5188.040212560688;5190.506901844319;5193.870153246161;5201;5222.190560463135;5223.817166399158;5226.189940559219;5226.97386513065;5260.1583746600745;4531.705439146445;4560.863174104782;4667.15991121598;4671.906561868744;4684.180268453007;5260.8952120054455;5263.6315457918345;5319.0957537218765;5325.440828713007;5346.85042715818;5058.949410505921;5073.264376665363;5091.389033315952;5130.9230361544605;5141.5886729061585;4838.564529192319;4956.851294461172;4974.651774375759;5197.688138711689;5231.450697676765;4946.975265123651;5038.2190760432195;5049.31834202378;5053;5079.619028572872;5055.469175736568;5111.258867464197;5127.307813445137;5129.717865517432;5161.561267292247;4057.3711074783455;4150.875473735793;4289.313709806478;4308.1814455254025;4333.393324934512;3587.820608969541;3624.9637503625154;3660.5973342932257;3668.761530500509;3688.944665830015;4476.283794592915;4514.548545145459;4517.096580683877;4522.095580883836;4545.36364908913;4862.9544647900875;4982.402111746541;5203.973980130151;5207.29701490294;5215.895682086337;4377.037051848588;4402.933955990663;4471.374007638933;4472.530384309601;4529.343245229424;4532.116237333688;4537.6143027843;4538.909221815546;4538.954610453853;4574.6340292776495;4602.516735742699;4721.929171062368;4895.31465594817;4895.877603059952;4911.066897289504;4939.036887806987;5090.389153301628;5208.619715775247;5242.266082748342;5244.685318880879;4787.54518320759;4792.880177995578;4796.66423350376;4801.51984801517;4829.613630909589;4741.715497070187;4976.303317535476;4982.850514484571;4985.252212168204;5021.824236151717;4984.22744474607;4998.500149984972;5052.46949070357;5171.224316352577;5223.660462069954;4945.975270123627;4946.530079642428;4950.975245123751;4953.777080031479;5004.374453193351;4711.952880471152;4967.602591792575;4981.028699403581;4989.625778066587;5001.624878134082;4813.302071199727;4834.6374021947795;4836.782344794422;4871.2206047032305;4892.706437613754;5013.24801279811;5104.259882317117;5112.923306150336;5123.87190320245;5158.277841102174;4558.840440584564;4930.852074437773;4947.6536642434685;4955.1823949048;4991.376077990251 18:42:39 INFO - 2015-11-17 18:42:39,685 DEBUG : BROWSER_OUTPUT: |1;ext.html;538.2598926476093;558.5782734035803;558.7904535799076;574.259205624744;579.2296245992829;28142.43715125699;28730;37228.069298267554;38178;38297;40295.39556906649;40824.75463849487;40906.795466022704;40967.590324096825;41073.56242531512;6926.445884329241;7807.804804879881;7957.283844453998;7959.880601790977;7965.044194696645;6968.756093536727;10248.795024099514;10520;10524.421156836372;10532.47337633119;10159.644412445567;10253.897461025406;10262.435566043865;10264.794704105914;10266.845997310047;7077.681504332266;7225.313595208447;10153.441560714158;10274.280800343942;10341.431221282826;9749.610015599368;9751.17115045222;9778.462184579845;9857.309988300822;9871.309008369417;37313.440298395544;37357.25285494302;37540.624593753986;38258.80870595657;38350.80824595859;2341.7658234176615;2570.5887058070807;2873.827570345786;2880.4095160492047;2893.667228268755;26924.192274231806;27257.86371068132;27560.586591201147;27719;28137.155885323475;2942.602748628929;2942.7057294270403;2959.6300462442196;3059.4187104450084;3059.816411015324;190769;191518;191864;191882;192998;43912.780436097615;44841.77579112084;44843.32735008912;44869.775651121534;44922.55077449249;63698.68150659217;63992.36007639957;64579.354206457334;64581.67709161518;64604.35395646077;11844.111691622991;11864.288142711464;12103.636890893287;12126.636200913987;12133.15067945253;8585.399022068521;8605.397622166514;8678.958524976917;8918.286537077018;8978.281737460988;18135.909320453313;18370;18374.53003759696;18425.815741842678;18459.723104153447;7371.9262807372315;7385.6307184640555;7591.620418979029;7608.695652173851;7610.8097297568;818.5457071325352;857.2584714222153;918.136951265808;961.8461046232709;1003.7540802503287;26428.33929151748;26496.205113846616;26661.200163995112;26695.33261668474;26761.732382676313;870.8824308718368;899.7975455522586;914.0767824497306;926.282131348197;932.244881645869;14234.572962811133;14610.196439195946;14725.55823325302;14888.404463821542;14939.626509337353;247651;251356;251495;251906;252024;46278.76860615743;46451.53548464472;46503.76748116238;46648.5335146651;46781.29828052582;1086.1528008153496;1097.1771171621283;1113.3041848844473;1114.7770445910687;1282.307553920891;25920.977475351574;26376.472470550867;26405.471890562465;26462.338441539116;26754.331141721614;39109.608903910594;39552.80223598864;39557;39598.60401395949;39762.801185993885;240196;242100;242334;243468;244883;23879.52240955206;24299.39251518726;27906.302342441602;28359.291017723895;28739.28151796222;32773.836130819196;32929.01212963615;38385.808070960586;38669.6133038666;39548;29698;29842.850785745934;30022.69977300199;30812.22969425782;31024.689753103085;30790;31351.84324078365;32357.191070223435;32658;32830;27189.59215611807;27685.169444916686;32277.677223227467;33028.1742956428;33501;26854.328641784112;29398.26504337323;29821.85089074541;30104.247393814454;30485.54271685882;22794.202202922817;23176.3047108587;23288.301350959497;23354.299371018897;23391 18:42:39 INFO - 2015-11-17 18:42:39,686 DEBUG : BROWSER_OUTPUT: |2;jquery.html;305.67598345753504;310.07597359867594;311.122634171636;311.2467827856587;314.0734832244877;11607.941960290187;12115.27308361499;13885.500609890229;14894.851051489482;15311.464098756545;11798.410079496034;14346.497872574462;14463.927680361583;14862.47981320654;14872.182029988346;3651.214988777412;4561.749103799298;4713.952860471403;4748.97625511872;4792.089502994438;4920.606351491872;4976.427710813248;4981.975090124544;4983.9252411213865;4984.127777638917;4375.540568240337;4934.333864928242;4935.210366341386;4936.925946110811;4938.2098864181735;4431.512533621299;4453.109378124388;4454.398656181406;4456.3315502674695;4457.977710111461;3744.3821769408014;3847.61523847613;3849.8267577958777;3851.9807400963095;3904.531456225271;11877;12099.697507562381;12106.455209515505;12151;12153.817692734616;1667.7415000674914;1674.5980964568537;1702.0553592756016;1702.7105392083377;1723.1212081838353;9120.087991200893;9235.907640923571;9249.583768730356;9358.157765801043;9370.95314523423;1595.9521214363588;1603.7514185301297;1609.4688752711577;1632.6244963658307;1653.1568899861156;52615.73692131553;53062.46937530652;53607.73196134033;53992.460075399526;54550.454495454935;6287.402696743802;6375.3624637536805;6391.712372943229;6399.8080057598345;6493.642849643315;7116.430685545144;7177.856442871113;7269.3094156055095;7271.2365201653065;7306.123265208103;4705.4588722296685;4719.10337035962;4759.190937540627;4769.070031343855;4776.164171270014;4854.417469903564;4903.26451032348;4905.337779399807;4944.208926571731;4950.702957822542;2962.4963756161505;2964.0663191094736;3016.834074125944;3030.848457577112;3033.9544906826413;1030.6032177611673;1031.4997226345367;1031.515187861704;1033.395463653756;1073.903348698621;362.20857426523133;379.7607507270402;393.2018003452995;394.26863168821995;413.65459841032475;10461.215408844368;10598.576056957789;10723.571057157626;10827.458627068616;10912.836307455394;354.65598369581465;400.3294481743069;409.92006558720766;412.03583614341983;419.56365380005064;5665.206871038058;5696.850452681858;5840.766369345179;6094.329623741385;6195.31851496335;485267;486296;491749;495353;496997;65163.348366515726;68196;68248.6587567059;68303.3169668307;68397;448.04342728275367;457.0516178928736;458.55749202019547;459.57489322376665;460.2153328574839;8404.705835295736;9829.901700983184;9926.553305101143;9950.10449059588;10017.949910250401;30745.846270768503;31326;31662.841685792344;32210.19474513156;32269.838650806596;38418.615813841505;40329;40377.99055023648;40492.1901561973;40546.18907621772;5922.851928701817;5955.374685657944;6032.155498230163;6032.939670603238;6193.659348735863;11151.944240278746;11392.48733806964;11426.828597570877;11529.250598711056;11647.893450122225;9823.36148150368;9981.151602113901;9989.850152247867;10363.170946324426;10368.429736364573;9540;9669.613215471583;9761.267904907018;9822.410655360702;9831.606735730777;9736.782902137233;9786.727725395653;9839.901600984185;9928.553215105194;9973.650922217688;5169.767360468863;5260.842174734764;5282.181261904411;5691.686957217393;5858.677772722371;9277.443353398818;9449.102335278412;9689.563969621526;9698.806023879624;9737.513124343895 18:42:39 INFO - 2015-11-17 18:42:39,688 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1392.7214557088573;1591.761235814628;1643.0552432351394;1665.2339923635127;1665.5836040989752;5708.800191993281;6390.233172019359;6460.483161347092;6519.054737063123;6529.2817790043055;6206;6617.470602351812;6626.436752875999;6627.138471998645;6637.269900310962;1919.9040047997614;1977.1399441243034;1987.2249822569138;1989.6816509358505;1994.2621230144866;1966.6263409952135;2002.5594369238818;2011.3362590345223;2031.7460317460318;2035.4707775978204;1989.7811240763576;2008.8192062714352;2028.6449871272541;2033.8305474352233;2034.6744520876662;1951.2292644405452;1960.725498430221;1964;1967.9409617711349;1970.5467742419323;1971.9802801972085;1988.0556735550642;1991.1139542903413;2017.6872584749387;2018.1826360324092;5502.312210973629;5705.343885453184;6661.566998145105;6713.93286067138;6725.730970761164;3482.286131343094;3539.3983022886173;3551.3607550640872;3886.844526218948;3976.363781794928;2677.6385187999567;2693.7844972402163;2701.6757989041243;2738.835669859815;2743.478739039576;874.1782724239195;874.6020560644955;876.6493402638931;894.9418287811271;900.9909900900973;8732.563371831446;8830.602622881986;8833.514156721378;8847.071057538995;8860.778480537974;3748;3759.6240375962184;3765.548134223911;3811.9809400953372;3819.52255968004;7862.882056769153;7864.764057078297;7866.646000929972;7867.567283799446;7903.446758726949;4114.938275925863;4124.938125928114;4137.648299894482;4138.503379594468;4141.79291035447;3652.36083685354;3658.268346330691;3663.5420572428447;3688.741788074809;3763.9247215055548;3124.5313203019273;3127.46833038384;3138.356636889432;3170.2074481379655;3175.8249447704034;960.0351646595267;962.2879069488667;965.560669895196;972.1979367022235;997.5660587644398;1116.1851848150734;1128.8081026225561;1137.2778285788584;1147.1683029803326;1149.224273615323;6312;6348.904766428507;6360;6362.981922892408;6413.358664133642;346.6862489447004;350.617826569041;351.26760703932587;351.542994107659;352.3376053020357;4388.846390376385;4747.548982846624;4858.198397264412;4874.561289483963;4875.780589873464;6589.769358072444;8101.675932962733;8126.821610866509;8130.75607731769;8138.877916831252;7942.927704759783;8018.639161237758;8029.277365037175;8029.678812847421;8034.437589368688;6111.35830737775;6291.6854157291955;6305.274893387227;6408.967955160194;6449.7420103195345;6322.841928951813;6338.90491642635;6339.96830015847;6346.492280617632;6359.395857393541;7112.857742845217;7173.282671732785;7186.065811444479;7276.126864776261;7295.197528271992;6770.45836333102;6977;6984.860302794017;7005.369516743517;7457.440691948234;5981.730822112929;5987.161797348462;6068.120122582289;6079.726412311368;6082.36135205797;6402.391772781578;6445.516586255956;6462.127612772404;6508.349165083454;6510.121133647087;6008.519318454426;6052.485538729257;6115.205023346936;6216.72024758896;6249.593776404519;5978.551608629457;6034.456898879122;6101.481374083075;6129.295131059986;6141.47797437205;5968.850778730566;6088.238970128734;6106.908396374147;6115.235595550556;6118.235220597426;5544.251526043932;5590.161475778666;5604.103343465026;5658.660480371191;5704.486596206195;5708.914366284426;5714.885702285847;5763.6541807491685;5788.797392091256;5799.449052340021 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: |4;prototype.html;284.5205828179517;287.547113296558;289.1354849001485;293.3970690231573;295.0073004340395;5420.457954204578;5428.701421421821;5475.4524547545225;5502.58730595206;5504.807331743395;5152.536271735543;5246.580273578114;5292.814751483699;5415.377231618365;5432.565394768419;4130.834766609347;4138.172365526892;4138.689598280126;4146.792660366985;4148.937765933513;3940.80295985201;4141.461609990697;4143.094176678732;4152.231837110145;4159.480064991876;3889.7082718796064;3892;3968.0675041365257;3990.8603198888045;4020.5778393268724;4020.718549701522;4020.8994775130564;4024.416459613369;4031.3952907064026;4044.1305119399176;3502.5096486491657;3512.227309991798;3517.876874309387;3526.770759900598;3528.1708798432346;5067.214581739836;5073.162928116856;5096.694198348111;5116.232565115262;5118.436971933084;4563.794629241692;4674.345591617176;4698.718076915362;4699.882502937419;4703.035877645075;5587.05020146576;5588.161775733632;5591.524720398771;5594.860128496779;5595.160725891108;3856.9614303856883;3860.575336712959;3861.2663593917346;3867.149227170018;3871.380579107329;5879.588428809985;5891.440313170285;5898.557608179361;5900.321463031763;5909.674967876722;3957.6438120569287;4031.9395209071886;4057.1479989202007;4057.229126465962;4065.329220678555;4117.2588933992165;4117.855875044359;4121.670266378683;4124.566920473367;4130.855420060344;4764.666473346832;4773.355596994361;4774.045190961821;4775;4779.330893674888;5712.65724056558;5738.512226460714;5748.683822389725;5750.827475175752;5757.136429535603;1440.9495667651581;1455.9417623294948;1461.3862177885314;1467.8238611366492;1470.8382077971414;938.5448057692014;973.3478569358547;977.6871401151564;984.8178087053918;985.7387792235063;5052.242163675478;5052.520010598987;5054.7472626368535;5057.266696329012;5067.315912351859;5936.28764548257;5936.5844390892225;5937.821865344046;5940.584159108907;5945.078512830518;4891.461939186686;4966.602671786249;5038.2190760432195;5057.949420505748;5060.898782024339;3156.952645710316;3186.8725250990165;3200.1839530919465;3233.531137984979;3238.5627940228237;5579.665220086727;5585.916211256835;5592.664440133605;5596.412376700469;5602.327720673464;5960.254968128984;6099.939000610026;6103.450689437972;6106.175666285084;6111;5580.358258800209;5604.467575580314;5610.803621873215;5613.663180209201;5618.353889302701;5915.08316210988;5927.555433342431;5928.733207005781;5931.940680593311;5932.317783454958;5784.132380143013;5798.478136967693;5803.158542011469;5805.796797112081;5808.39011903744;5479.53423958952;5594.664320140804;5595.300587426572;5606.299212598426;5607.607467477401;4040.252553277653;4052.412400202013;4054.2499637567144;4057.1682805024307;4057.188562287495;5911.290645122441;5913;5919.141724450017;5920.141579470866;5920.911186332122;5604.719764011865;5683.829485115453;5695.117256825199;5725.141228815711;5741.311042674905;5720.656760594377;5738.8278351649515;5741.45456181662;5744.080947048452;5747.798827041033;5608.383077861514;5612.7754889803955;5614.333191733894;5616.85957851057;5625.268715067179;5757.453041961007;5763.337216220189;5781.988152073286;5804.796832110856;5813.476787089182;5500.80747173863;5598.300212473441;5626.24045753818;5628.324601047901;5633.126865335879 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: |5;yui.html;652.8335274505;710.7299226294008;760.646299470746;777.7433446962503;788.2393490281879;11224.214304998653;11388.430578471063;11433.085353171726;11458.7135321617;11460.025897798687;10595.152387808976;10606.575736970532;10686.839697404544;10699.304545204557;10701.83947240792;764.5794812852937;794.1661255681511;799.9520028798262;799.952002879829;800.2677550041705;772.4862966127519;792.3819420851745;792.8771040488733;795.7016118955391;797.2306724011328;807.1605530248535;830.0620299062051;833.7248707926369;833.7415401225609;833.8415701016787;808.0747544062075;809.3323008517967;818.4025661267308;824.0276473760989;824.2993455562784;592.6562593695646;596.6599038548029;605.4581149870885;605.8273392083279;605.8333958161497;10564.841527377095;10566.9471652642;10584.259101862872;10622.57509699611;10665.733356666145;8989.146031127033;9198.356115071947;9360.53197340137;9815.263855210887;10159.187265018782;8703.869441958375;8764.8685269721;8775.341849361323;8790.340724445692;8884.2892568595;3172.1752344390625;3181.984090079558;3242.9837850810595;3268.444364458048;3319.2697606526526;36855;37605.43591846125;38288.234235315416;39118.80440597807;41064;9289.721308360626;9401.811963760687;9500.097490738368;9550.570224339921;9560.90439095614;16119.032858028555;16139.838601614068;16159;16170.919145404432;16228.432004879773;5904.202932604129;5916.585838991229;6056.697165141725;6195.690215489298;6222.502199824004;3409.7272218222483;3512.051746028558;3532.346515894568;3537.8231088445473;3545.62770909056;2772.5148099082985;2803.7897157713255;2809.9438011239663;2810.8172968757376;2811.1988083396136;405.5944055944056;416.26736942979966;417.2989377845249;419.40235164889907;425.37045173143304;491.9434265059492;501.2456253338702;566.8724536979229;580.3471095018105;607.8662694207268;7804.648790804427;8161.469504482189;8750;8815.735527934172;9064.138906803842;421.0799403303791;421.6277205380227;443.36598663910917;565.2341077839468;590.2356448399333;3743.401055831054;3870.670992965573;3894.415837624322;3905.082305658168;3914.4911161548816;54747.45252547503;55888;56183.71908140433;56317.71841140768;56396.43603563994;48984;49024.754876225394;49346.50653493419;49416;49430;35101.64898351035;36389.81805091011;36460.45309320362;39449.80275098606;40550.79724601358;8239.917600823916;8301.418900676894;8461.830763384574;8509.87235191485;9019.774505637411;31729.5240571387;32583;32834.67165328316;32930;32949.670503295616;34157.829210853786;34669.30661386708;35844.820775895954;41004.589954100076;41495.377569337084;6522.445592124533;6773.254941956479;6900.9654951726925;6927.965360173167;7207.207207207308;11083.334999900031;11554.133439992202;11557.30656160633;11716.472758726048;11924.642260732191;10065.949670251603;10070.748231294276;10270.897291026995;10829.346810031593;10939.671809845717;10762.3542587445;11128.44357782124;11286.604968826052;11308;11583.5945741902;10314.756508179324;10462.372257664565;10791.190660700322;10930.45347732626;11098.2786118902;9466.432014079177;9625.56684949193;9650.613975441185;9684.56419461112;9890.060444257784;9042.803328432828;9100.247629161746;9267.629294828132;9318.580663870278;9346.345755797029 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,861 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814559679__endTimestamp 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,689 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:42:39 INFO - 2015-11-17 18:42:39,690 DEBUG : BROWSER_OUTPUT: Number of tests: 6 18:42:39 INFO - 2015-11-17 18:42:39,690 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,690 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4700.27 Median:4796.66 stddev:513.15 (10.7%) stddev-sans-first:487.09 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: Values: 2582.8 2665.3 2713.9 2734.9 2751.9 4392.1 4524.5 4618.1 4720.7 4721.3 4622.9 4658.9 4684.3 4731.1 4756.0 4286.4 4326.7 4334.0 4457.4 4549.2 4357.3 4448.9 4453.1 4468.5 4501.7 4126.5 4134.8 4233.5 4261.6 4332.6 4402.7 4407.4 4416.4 4426.9 4462.6 4392.3 4415.2 4419.1 4439.6 4454.8 4482.7 4600.7 4604.5 4643.8 4751.6 5171.7 5188.0 5190.5 5193.9 5201.0 5222.2 5223.8 5226.2 5227.0 5260.2 4531.7 4560.9 4667.2 4671.9 4684.2 5260.9 5263.6 5319.1 5325.4 5346.9 5058.9 5073.3 5091.4 5130.9 5141.6 4838.6 4956.9 4974.7 5197.7 5231.5 4947.0 5038.2 5049.3 5053.0 5079.6 5055.5 5111.3 5127.3 5129.7 5161.6 4057.4 4150.9 4289.3 4308.2 4333.4 3587.8 3625.0 3660.6 3668.8 3688.9 4476.3 4514.5 4517.1 4522.1 4545.4 4863.0 4982.4 5204.0 5207.3 5215.9 4377.0 4402.9 4471.4 4472.5 4529.3 4532.1 4537.6 4538.9 4539.0 4574.6 4602.5 4721.9 4895.3 4895.9 4911.1 4939.0 5090.4 5208.6 5242.3 5244.7 4787.5 4792.9 4796.7 4801.5 4829.6 4741.7 4976.3 4982.9 4985.3 5021.8 4984.2 4998.5 5052.5 5171.2 5223.7 4946.0 4946.5 4951.0 4953.8 5004.4 4712.0 4967.6 4981.0 4989.6 5001.6 4813.3 4834.6 4836.8 4871.2 4892.7 5013.2 5104.3 5112.9 5123.9 5158.3 4558.8 4930.9 4947.7 4955.2 4991.4 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:38867.71 Median:30063.47 stddev:59827.62 (199.0%) stddev-sans-first:59926.23 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: Values: 538.3 558.6 558.8 574.3 579.2 28142.4 28730.0 37228.1 38178.0 38297.0 40295.4 40824.8 40906.8 40967.6 41073.6 6926.4 7807.8 7957.3 7959.9 7965.0 6968.8 10248.8 10520.0 10524.4 10532.5 10159.6 10253.9 10262.4 10264.8 10266.8 7077.7 7225.3 10153.4 10274.3 10341.4 9749.6 9751.2 9778.5 9857.3 9871.3 37313.4 37357.3 37540.6 38258.8 38350.8 2341.8 2570.6 2873.8 2880.4 2893.7 26924.2 27257.9 27560.6 27719.0 28137.2 2942.6 2942.7 2959.6 3059.4 3059.8 190769.0 191518.0 191864.0 191882.0 192998.0 43912.8 44841.8 44843.3 44869.8 44922.6 63698.7 63992.4 64579.4 64581.7 64604.4 11844.1 11864.3 12103.6 12126.6 12133.2 8585.4 8605.4 8679.0 8918.3 8978.3 18135.9 18370.0 18374.5 18425.8 18459.7 7371.9 7385.6 7591.6 7608.7 7610.8 818.5 857.3 918.1 961.8 1003.8 26428.3 26496.2 26661.2 26695.3 26761.7 870.9 899.8 914.1 926.3 932.2 14234.6 14610.2 14725.6 14888.4 14939.6 247651.0 251356.0 251495.0 251906.0 252024.0 46278.8 46451.5 46503.8 46648.5 46781.3 1086.2 1097.2 1113.3 1114.8 1282.3 25921.0 26376.5 26405.5 26462.3 26754.3 39109.6 39552.8 39557.0 39598.6 39762.8 240196.0 242100.0 242334.0 243468.0 244883.0 23879.5 24299.4 27906.3 28359.3 28739.3 32773.8 32929.0 38385.8 38669.6 39548.0 29698.0 29842.9 30022.7 30812.2 31024.7 30790.0 31351.8 32357.2 32658.0 32830.0 27189.6 27685.2 32277.7 33028.2 33501.0 26854.3 29398.3 29821.9 30104.2 30485.5 22794.2 23176.3 23288.3 23354.3 23391.0 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24337.97 Median:2582.84 stddev:80442.92 (3114.5%) stddev-sans-first:80648.34 18:42:39 INFO - 2015-11-17 18:42:39,691 DEBUG : BROWSER_OUTPUT: Values: 305.7 310.1 311.1 311.2 314.1 11607.9 12115.3 13885.5 14894.9 15311.5 11798.4 14346.5 14463.9 14862.5 14872.2 3651.2 4561.7 4714.0 4749.0 4792.1 4920.6 4976.4 4982.0 4983.9 4984.1 4375.5 4934.3 4935.2 4936.9 4938.2 4431.5 4453.1 4454.4 4456.3 4458.0 3744.4 3847.6 3849.8 3852.0 3904.5 11877.0 12099.7 12106.5 12151.0 12153.8 1667.7 1674.6 1702.1 1702.7 1723.1 9120.1 9235.9 9249.6 9358.2 9371.0 1596.0 1603.8 1609.5 1632.6 1653.2 52615.7 53062.5 53607.7 53992.5 54550.5 6287.4 6375.4 6391.7 6399.8 6493.6 7116.4 7177.9 7269.3 7271.2 7306.1 4705.5 4719.1 4759.2 4769.1 4776.2 4854.4 4903.3 4905.3 4944.2 4950.7 2962.5 2964.1 3016.8 3030.8 3034.0 1030.6 1031.5 1031.5 1033.4 1073.9 362.2 379.8 393.2 394.3 413.7 10461.2 10598.6 10723.6 10827.5 10912.8 354.7 400.3 409.9 412.0 419.6 5665.2 5696.9 5840.8 6094.3 6195.3 485267.0 486296.0 491749.0 495353.0 496997.0 65163.3 68196.0 68248.7 68303.3 68397.0 448.0 457.1 458.6 459.6 460.2 8404.7 9829.9 9926.6 9950.1 10017.9 30745.8 31326.0 31662.8 32210.2 32269.8 38418.6 40329.0 40378.0 40492.2 40546.2 5922.9 5955.4 6032.2 6032.9 6193.7 11151.9 11392.5 11426.8 11529.3 11647.9 9823.4 9981.2 9989.9 10363.2 10368.4 9540.0 9669.6 9761.3 9822.4 9831.6 9736.8 9786.7 9839.9 9928.6 9973.7 5169.8 5260.8 5282.2 5691.7 5858.7 9277.4 9449.1 9689.6 9698.8 9737.5 18:42:39 INFO - 2015-11-17 18:42:39,692 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,692 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4662.94 Median:5984.45 stddev:2396.77 (40.1%) stddev-sans-first:2390.89 18:42:39 INFO - 2015-11-17 18:42:39,693 DEBUG : BROWSER_OUTPUT: Values: 1392.7 1591.8 1643.1 1665.2 1665.6 5708.8 6390.2 6460.5 6519.1 6529.3 6206.0 6617.5 6626.4 6627.1 6637.3 1919.9 1977.1 1987.2 1989.7 1994.3 1966.6 2002.6 2011.3 2031.7 2035.5 1989.8 2008.8 2028.6 2033.8 2034.7 1951.2 1960.7 1964.0 1967.9 1970.5 1972.0 1988.1 1991.1 2017.7 2018.2 5502.3 5705.3 6661.6 6713.9 6725.7 3482.3 3539.4 3551.4 3886.8 3976.4 2677.6 2693.8 2701.7 2738.8 2743.5 874.2 874.6 876.6 894.9 901.0 8732.6 8830.6 8833.5 8847.1 8860.8 3748.0 3759.6 3765.5 3812.0 3819.5 7862.9 7864.8 7866.6 7867.6 7903.4 4114.9 4124.9 4137.6 4138.5 4141.8 3652.4 3658.3 3663.5 3688.7 3763.9 3124.5 3127.5 3138.4 3170.2 3175.8 960.0 962.3 965.6 972.2 997.6 1116.2 1128.8 1137.3 1147.2 1149.2 6312.0 6348.9 6360.0 6363.0 6413.4 346.7 350.6 351.3 351.5 352.3 4388.8 4747.5 4858.2 4874.6 4875.8 6589.8 8101.7 8126.8 8130.8 8138.9 7942.9 8018.6 8029.3 8029.7 8034.4 6111.4 6291.7 6305.3 6409.0 6449.7 6322.8 6338.9 6340.0 6346.5 6359.4 7112.9 7173.3 7186.1 7276.1 7295.2 6770.5 6977.0 6984.9 7005.4 7457.4 5981.7 5987.2 6068.1 6079.7 6082.4 6402.4 6445.5 6462.1 6508.3 6510.1 6008.5 6052.5 6115.2 6216.7 6249.6 5978.6 6034.5 6101.5 6129.3 6141.5 5968.9 6088.2 6106.9 6115.2 6118.2 5544.3 5590.2 5604.1 5658.7 5704.5 5708.9 5714.9 5763.7 5788.8 5799.4 18:42:39 INFO - 2015-11-17 18:42:39,693 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,693 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4700.00 Median:5430.63 stddev:1404.67 (25.9%) stddev-sans-first:1368.96 18:42:39 INFO - 2015-11-17 18:42:39,694 DEBUG : BROWSER_OUTPUT: Values: 284.5 287.5 289.1 293.4 295.0 5420.5 5428.7 5475.5 5502.6 5504.8 5152.5 5246.6 5292.8 5415.4 5432.6 4130.8 4138.2 4138.7 4146.8 4148.9 3940.8 4141.5 4143.1 4152.2 4159.5 3889.7 3892.0 3968.1 3990.9 4020.6 4020.7 4020.9 4024.4 4031.4 4044.1 3502.5 3512.2 3517.9 3526.8 3528.2 5067.2 5073.2 5096.7 5116.2 5118.4 4563.8 4674.3 4698.7 4699.9 4703.0 5587.1 5588.2 5591.5 5594.9 5595.2 3857.0 3860.6 3861.3 3867.1 3871.4 5879.6 5891.4 5898.6 5900.3 5909.7 3957.6 4031.9 4057.1 4057.2 4065.3 4117.3 4117.9 4121.7 4124.6 4130.9 4764.7 4773.4 4774.0 4775.0 4779.3 5712.7 5738.5 5748.7 5750.8 5757.1 1440.9 1455.9 1461.4 1467.8 1470.8 938.5 973.3 977.7 984.8 985.7 5052.2 5052.5 5054.7 5057.3 5067.3 5936.3 5936.6 5937.8 5940.6 5945.1 4891.5 4966.6 5038.2 5057.9 5060.9 3157.0 3186.9 3200.2 3233.5 3238.6 5579.7 5585.9 5592.7 5596.4 5602.3 5960.3 6099.9 6103.5 6106.2 6111.0 5580.4 5604.5 5610.8 5613.7 5618.4 5915.1 5927.6 5928.7 5931.9 5932.3 5784.1 5798.5 5803.2 5805.8 5808.4 5479.5 5594.7 5595.3 5606.3 5607.6 4040.3 4052.4 4054.2 4057.2 4057.2 5911.3 5913.0 5919.1 5920.1 5920.9 5604.7 5683.8 5695.1 5725.1 5741.3 5720.7 5738.8 5741.5 5744.1 5747.8 5608.4 5612.8 5614.3 5616.9 5625.3 5757.5 5763.3 5782.0 5804.8 5813.5 5500.8 5598.3 5626.2 5628.3 5633.1 18:42:39 INFO - 2015-11-17 18:42:39,694 DEBUG : BROWSER_OUTPUT: 18:42:39 INFO - 2015-11-17 18:42:39,694 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12225.70 Median:24758.35 stddev:14346.01 (57.9%) stddev-sans-first:14359.93 18:42:39 INFO - 2015-11-17 18:42:39,694 DEBUG : BROWSER_OUTPUT: Values: 652.8 710.7 760.6 777.7 788.2 11224.2 11388.4 11433.1 11458.7 11460.0 10595.2 10606.6 10686.8 10699.3 10701.8 764.6 794.2 800.0 800.0 800.3 772.5 792.4 792.9 795.7 797.2 807.2 830.1 833.7 833.7 833.8 808.1 809.3 818.4 824.0 824.3 592.7 596.7 605.5 605.8 605.8 10564.8 10566.9 10584.3 10622.6 10665.7 8989.1 9198.4 9360.5 9815.3 10159.2 8703.9 8764.9 8775.3 8790.3 8884.3 3172.2 3182.0 3243.0 3268.4 3319.3 36855.0 37605.4 38288.2 39118.8 41064.0 9289.7 9401.8 9500.1 9550.6 9560.9 16119.0 16139.8 16159.0 16170.9 16228.4 5904.2 5916.6 6056.7 6195.7 6222.5 3409.7 3512.1 3532.3 3537.8 3545.6 2772.5 2803.8 2809.9 2810.8 2811.2 405.6 416.3 417.3 419.4 425.4 491.9 501.2 566.9 580.3 607.9 7804.6 8161.5 8750.0 8815.7 9064.1 421.1 421.6 443.4 565.2 590.2 3743.4 3870.7 3894.4 3905.1 3914.5 54747.5 55888.0 56183.7 56317.7 56396.4 48984.0 49024.8 49346.5 49416.0 49430.0 35101.6 36389.8 36460.5 39449.8 40550.8 8239.9 8301.4 8461.8 8509.9 9019.8 31729.5 32583.0 32834.7 32930.0 32949.7 34157.8 34669.3 35844.8 41004.6 41495.4 6522.4 6773.3 6901.0 6928.0 7207.2 11083.3 11554.1 11557.3 11716.5 11924.6 10065.9 10070.7 10270.9 10829.3 10939.7 10762.4 11128.4 11286.6 11308.0 11583.6 10314.8 10462.4 10791.2 10930.5 11098.3 9466.4 9625.6 9650.6 9684.6 9890.1 9042.8 9100.2 9267.6 9318.6 9346.3 18:42:39 INFO - 2015-11-17 18:42:39,696 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:42:39 INFO - 2015-11-17 18:42:39,696 DEBUG : BROWSER_OUTPUT: 18:42:40 INFO - 2015-11-17 18:42:40,415 INFO : Browser exited with error code: 0 18:42:40 INFO - 2015-11-17 18:42:40,437 INFO : Completed test dromaeo_css (00:18:40) 18:42:40 INFO - 2015-11-17 18:42:40,437 INFO : Starting test kraken 18:42:40 INFO - 2015-11-17 18:42:40,437 DEBUG : operating with platform_type : linux_ 18:42:40 INFO - 2015-11-17 18:42:40,437 INFO : Initialising browser for kraken test... 18:42:40 INFO - 2015-11-17 18:42:40,443 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4HI7ps/profile http://localhost:44008/getInfo.html 18:42:44 INFO - 2015-11-17 18:42:44,932 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:44 INFO - 2015-11-17 18:42:44,933 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:44 INFO - 2015-11-17 18:42:44,933 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:42:44 INFO - 2015-11-17 18:42:44,933 DEBUG : BROWSER_OUTPUT: __metrics 18:42:45 INFO - 2015-11-17 18:42:45,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:42:45 INFO - 2015-11-17 18:42:45,804 DEBUG : BROWSER_OUTPUT: console.error: 18:42:45 INFO - 2015-11-17 18:42:45,807 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 18:42:45 INFO - 2015-11-17 18:42:45,807 DEBUG : BROWSER_OUTPUT: Stack: 18:42:45 INFO - 2015-11-17 18:42:45,807 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 18:42:45 INFO - 2015-11-17 18:42:45,808 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:42:45 INFO - 2015-11-17 18:42:45,809 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 18:42:45 INFO - 2015-11-17 18:42:45,809 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:523:9 18:42:45 INFO - 2015-11-17 18:42:45,809 DEBUG : BROWSER_OUTPUT: 18:42:46 INFO - 2015-11-17 18:42:46,464 INFO : Browser initialized. 18:42:46 INFO - 2015-11-17 18:42:46,464 INFO : Running cycle 1/1 for kraken test... 18:42:46 INFO - 2015-11-17 18:42:46,464 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4HI7ps/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:42:58 INFO - 2015-11-17 18:42:58,400 DEBUG : BROWSER_OUTPUT: RSS: Main: 138981376 18:42:58 INFO - 2015-11-17 18:42:58,400 DEBUG : BROWSER_OUTPUT: 18:43:01 INFO - 2015-11-17 18:43:01,017 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:44008/tests/kraken/driver.html?testName=audio-beat-detection) 18:43:01 INFO - 2015-11-17 18:43:01,610 DEBUG : BROWSER_OUTPUT: RSS: Main: 178462720 18:43:01 INFO - 2015-11-17 18:43:01,611 DEBUG : BROWSER_OUTPUT: 18:43:04 INFO - 2015-11-17 18:43:04,357 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:44008/tests/kraken/driver.html?testName=audio-dft) 18:43:04 INFO - 2015-11-17 18:43:04,938 DEBUG : BROWSER_OUTPUT: RSS: Main: 168951808 18:43:04 INFO - 2015-11-17 18:43:04,938 DEBUG : BROWSER_OUTPUT: 18:43:07 INFO - 2015-11-17 18:43:07,963 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:44008/tests/kraken/driver.html?testName=audio-fft) 18:43:08 INFO - 2015-11-17 18:43:08,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 152612864 18:43:08 INFO - 2015-11-17 18:43:08,537 DEBUG : BROWSER_OUTPUT: 18:43:10 INFO - 2015-11-17 18:43:10,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:44008/tests/kraken/driver.html?testName=audio-oscillator) 18:43:11 INFO - 2015-11-17 18:43:11,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 155041792 18:43:11 INFO - 2015-11-17 18:43:11,167 DEBUG : BROWSER_OUTPUT: 18:43:13 INFO - 2015-11-17 18:43:13,393 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:44008/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:43:13 INFO - 2015-11-17 18:43:13,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 154333184 18:43:13 INFO - 2015-11-17 18:43:13,954 DEBUG : BROWSER_OUTPUT: 18:43:16 INFO - 2015-11-17 18:43:16,979 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:44008/tests/kraken/driver.html?testName=imaging-darkroom) 18:43:17 INFO - 2015-11-17 18:43:17,552 DEBUG : BROWSER_OUTPUT: RSS: Main: 156524544 18:43:17 INFO - 2015-11-17 18:43:17,552 DEBUG : BROWSER_OUTPUT: 18:43:21 INFO - 2015-11-17 18:43:21,023 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:44008/tests/kraken/driver.html?testName=imaging-desaturate) 18:43:21 INFO - 2015-11-17 18:43:21,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 156119040 18:43:21 INFO - 2015-11-17 18:43:21,598 DEBUG : BROWSER_OUTPUT: 18:43:24 INFO - 2015-11-17 18:43:24,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:44008/tests/kraken/driver.html?testName=json-parse-financial) 18:43:25 INFO - 2015-11-17 18:43:25,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 155508736 18:43:25 INFO - 2015-11-17 18:43:25,016 DEBUG : BROWSER_OUTPUT: 18:43:26 INFO - 2015-11-17 18:43:26,806 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:44008/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:43:27 INFO - 2015-11-17 18:43:27,367 DEBUG : BROWSER_OUTPUT: RSS: Main: 164823040 18:43:27 INFO - 2015-11-17 18:43:27,367 DEBUG : BROWSER_OUTPUT: 18:43:29 INFO - 2015-11-17 18:43:29,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:43:29 INFO - 2015-11-17 18:43:29,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 163315712 18:43:29 INFO - 2015-11-17 18:43:29,844 DEBUG : BROWSER_OUTPUT: 18:43:33 INFO - 2015-11-17 18:43:33,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:43:34 INFO - 2015-11-17 18:43:34,269 DEBUG : BROWSER_OUTPUT: RSS: Main: 162824192 18:43:34 INFO - 2015-11-17 18:43:34,269 DEBUG : BROWSER_OUTPUT: 18:43:36 INFO - 2015-11-17 18:43:36,812 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:43:37 INFO - 2015-11-17 18:43:37,401 DEBUG : BROWSER_OUTPUT: RSS: Main: 178974720 18:43:37 INFO - 2015-11-17 18:43:37,401 DEBUG : BROWSER_OUTPUT: 18:43:40 INFO - 2015-11-17 18:43:40,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:43:40 INFO - 2015-11-17 18:43:40,618 DEBUG : BROWSER_OUTPUT: RSS: Main: 180682752 18:43:40 INFO - 2015-11-17 18:43:40,618 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,387 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:44008/tests/kraken/driver.html?testName=ai-astar) 18:43:42 INFO - 2015-11-17 18:43:42,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 238505984 18:43:42 INFO - 2015-11-17 18:43:42,633 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;109;114;114;114;124;115;114;114;114 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;131;153;170;133;160;155;141;180;141 18:43:42 INFO - 2015-11-17 18:43:42,637 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;162;162;165;160;163;162;162;162 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;74;82;92;73;73;73;96;93;72 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;93;139;92;92;92;125;92;93;127 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;110;110;110;110;109;109;110 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;149;148;150;148;148;148;148;149;148 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;96;96;96;96;95;96 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;75;74;73;73;73;81;70;71 18:43:42 INFO - 2015-11-17 18:43:42,638 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;70;69;70;70;69;71;70;71;70 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;88;84;85;83;84;84;85;84 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;121;130;122;135;121;122;123;121;122 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;147;145;155;156;144;141;157;152;153;146 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;71;69;69;69;69;69;69;71;69 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: __start_cc_report 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,988 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: __end_cc_report 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814622634__endTimestamp 18:43:42 INFO - 2015-11-17 18:43:42,639 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: Number of tests: 14 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.60 Median:114.00 stddev:3.69 (3.2%) stddev-sans-first:3.91 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: Values: 114.0 109.0 114.0 114.0 114.0 124.0 115.0 114.0 114.0 114.0 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.80 Median:154.50 stddev:15.74 (10.2%) stddev-sans-first:16.67 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: Values: 154.0 131.0 153.0 170.0 133.0 160.0 155.0 141.0 180.0 141.0 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:1.35 (0.8%) stddev-sans-first:1.30 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 162.0 162.0 165.0 160.0 163.0 162.0 162.0 162.0 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,643 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:78.00 stddev:9.91 (12.7%) stddev-sans-first:10.08 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 82.0 92.0 73.0 73.0 73.0 96.0 93.0 72.0 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.80 Median:92.00 stddev:18.66 (20.3%) stddev-sans-first:19.38 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: Values: 93.0 93.0 139.0 92.0 92.0 92.0 125.0 92.0 93.0 127.0 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.50 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.50 Median:148.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: Values: 149.0 149.0 148.0 150.0 148.0 148.0 148.0 148.0 149.0 148.0 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 96.0 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,644 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:73.50 stddev:2.95 (4.0%) stddev-sans-first:3.12 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 75.0 74.0 73.0 73.0 73.0 81.0 70.0 71.0 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.90 Median:70.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 69.0 70.0 70.0 69.0 71.0 70.0 71.0 70.0 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.90 Median:85.00 stddev:1.45 (1.7%) stddev-sans-first:1.48 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 88.0 84.0 85.0 83.0 84.0 84.0 85.0 84.0 18:43:42 INFO - 2015-11-17 18:43:42,645 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.40 Median:122.50 stddev:4.77 (3.9%) stddev-sans-first:4.96 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: Values: 127.0 121.0 130.0 122.0 135.0 121.0 122.0 123.0 121.0 122.0 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.60 Median:152.50 stddev:5.66 (3.7%) stddev-sans-first:5.93 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: Values: 147.0 145.0 155.0 156.0 144.0 141.0 157.0 152.0 153.0 146.0 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 69.0 69.0 69.0 69.0 69.0 69.0 71.0 69.0 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:43:42 INFO - 2015-11-17 18:43:42,646 DEBUG : BROWSER_OUTPUT: 18:43:43 INFO - 2015-11-17 18:43:43,603 INFO : Browser exited with error code: 0 18:43:43 INFO - 2015-11-17 18:43:43,652 INFO : Completed test kraken (00:01:03) 18:43:43 INFO - 2015-11-17 18:43:43,652 INFO : Starting test v8_7 18:43:43 INFO - 2015-11-17 18:43:43,652 DEBUG : operating with platform_type : linux_ 18:43:43 INFO - 2015-11-17 18:43:43,652 INFO : Initialising browser for v8_7 test... 18:43:43 INFO - 2015-11-17 18:43:43,658 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VPDWw/profile http://localhost:44008/getInfo.html 18:43:48 INFO - 2015-11-17 18:43:48,102 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:43:48 INFO - 2015-11-17 18:43:48,103 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:43:48 INFO - 2015-11-17 18:43:48,103 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 18:43:48 INFO - 2015-11-17 18:43:48,103 DEBUG : BROWSER_OUTPUT: __metrics 18:43:48 INFO - 2015-11-17 18:43:48,179 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 18:43:49 INFO - 2015-11-17 18:43:49,579 INFO : Browser initialized. 18:43:49 INFO - 2015-11-17 18:43:49,580 INFO : Running cycle 1/1 for v8_7 test... 18:43:49 INFO - 2015-11-17 18:43:49,580 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp7VPDWw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:44:01 INFO - 2015-11-17 18:44:01,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 139575296 18:44:01 INFO - 2015-11-17 18:44:01,534 DEBUG : BROWSER_OUTPUT: 18:44:22 INFO - 2015-11-17 18:44:22,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:44008/tests/v8_7/run.html (next: http://localhost:44008/tests/v8_7/run.html) 18:44:23 INFO - 2015-11-17 18:44:23,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 436719616 18:44:23 INFO - 2015-11-17 18:44:23,228 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,229 DEBUG : BROWSER_OUTPUT: __start_tp_report 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |0;Richards;162.99918500407497 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.3238308179616 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.97780275358247 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5025.125628140703 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2018.1451612903227 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |5;Earley;796.8127490039841 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |6;Boyer;12180.722891566265 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |7;RegExp;27108.108108108107 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |8;Splay;605.294825511432 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 18:44:23 INFO - 2015-11-17 18:44:23,230 DEBUG : BROWSER_OUTPUT: __end_tp_report 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: __startTimestamp1447814663229__endTimestamp 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: Number of tests: 10 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,231 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.00 Median:163.00 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,232 DEBUG : BROWSER_OUTPUT: Values: 163.0 18:44:23 INFO - 2015-11-17 18:44:23,232 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,232 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.32 Median:186.32 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,232 DEBUG : BROWSER_OUTPUT: Values: 186.3 18:44:23 INFO - 2015-11-17 18:44:23,232 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.98 Median:280.98 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: Values: 281.0 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5025.13 Median:5025.13 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: Values: 5025.1 18:44:23 INFO - 2015-11-17 18:44:23,233 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2018.15 Median:2018.15 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: Values: 2018.1 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:796.81 Median:796.81 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: Values: 796.8 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12180.72 Median:12180.72 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: Values: 12180.7 18:44:23 INFO - 2015-11-17 18:44:23,235 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27108.11 Median:27108.11 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: Values: 27108.1 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.29 Median:605.29 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: Values: 605.3 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: Values: 4850.2 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 18:44:23 INFO - 2015-11-17 18:44:23,236 DEBUG : BROWSER_OUTPUT: 18:44:24 INFO - 2015-11-17 18:44:24,215 INFO : Browser exited with error code: 0 18:44:24 INFO - 2015-11-17 18:44:24,232 INFO : Completed test v8_7 (00:00:40) 18:44:24 INFO - 2015-11-17 18:44:24,239 INFO : Completed test suite (00:20:24) 18:44:24 INFO - 2015-11-17 18:44:24,239 DEBUG : Working with test: dromaeo_css 18:44:24 INFO - 2015-11-17 18:44:24,239 DEBUG : Generating results file: dromaeo_css 18:44:24 INFO - 2015-11-17 18:44:24,240 DEBUG : Working with test: kraken 18:44:24 INFO - 2015-11-17 18:44:24,240 DEBUG : Generating results file: kraken 18:44:24 INFO - 2015-11-17 18:44:24,240 INFO : javascript benchmark 18:44:24 INFO - 2015-11-17 18:44:24,241 DEBUG : Working with test: v8_7 18:44:24 INFO - 2015-11-17 18:44:24,241 DEBUG : Generating results file: v8_7 18:44:24 INFO - 2015-11-17 18:44:24,241 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:24 INFO - 2015-11-17 18:44:24,294 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 18:44:24 INFO - 2015-11-17 18:44:24,294 DEBUG : process_Request line: dromaeo_css 5922.20 graph.html#tests=[[72,131,35]] 18:44:24 INFO - 2015-11-17 18:44:24,294 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:24 INFO - 2015-11-17 18:44:24,328 DEBUG : process_Request line: kraken 1538.50 graph.html#tests=[[232,131,35]] 18:44:24 INFO - 2015-11-17 18:44:24,328 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 18:44:24 INFO - 2015-11-17 18:44:24,355 DEBUG : process_Request line: v8_7 19811.12 graph.html#tests=[[230,131,35]] 18:44:24 INFO - 2015-11-17 18:44:24,356 INFO : javascript benchmark 18:44:24 INFO - 2015-11-17 18:44:24,360 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2582.7933765298776, 2665.307020174754, 2713.945721085577, 2734.890604375825, 2751.8761655725502, 4392.099619577987, 4524.479684836245, 4618.076384723056, 4720.69315494493, 4721.339012538238, 4622.907541849161, 4658.90682186356, 4684.297355396692, 4731.124741922738, 4755.976220118903, 4286.442762440878, 4326.6538676905775, 4334.0, 4457.39825123609, 4549.203889319372, 4357.346398040288, 4448.933266001012, 4453.087117140978, 4468.463784345883, 4501.707389019703, 4126.48418947633, 4134.772587507686, 4233.491980962273, 4261.552536983603, 4332.588404101605, 4402.713823601455, 4407.405000324947, 4416.447944006999, 4426.867193984153, 4462.598366147063, 4392.3191905254735, 4415.161119387306, 4419.138268037702, 4439.622632076277, 4454.844080457168, 4482.663800214964, 4600.654950878664, 4604.5165257647795, 4643.837465688718, 4751.596114330286, 5171.741412929338, 5188.040212560688, 5190.506901844319, 5193.870153246161, 5201.0, 5222.190560463135, 5223.817166399158, 5226.189940559219, 5226.97386513065, 5260.1583746600745, 4531.705439146445, 4560.863174104782, 4667.15991121598, 4671.906561868744, 4684.180268453007, 5260.8952120054455, 5263.6315457918345, 5319.0957537218765, 5325.440828713007, 5346.85042715818, 5058.949410505921, 5073.264376665363, 5091.389033315952, 5130.9230361544605, 5141.5886729061585, 4838.564529192319, 4956.851294461172, 4974.651774375759, 5197.688138711689, 5231.450697676765, 4946.975265123651, 5038.2190760432195, 5049.31834202378, 5053.0, 5079.619028572872, 5055.469175736568, 5111.258867464197, 5127.307813445137, 5129.717865517432, 5161.561267292247, 4057.3711074783455, 4150.875473735793, 4289.313709806478, 4308.1814455254025, 4333.393324934512, 3587.820608969541, 3624.9637503625154, 3660.5973342932257, 3668.761530500509, 3688.944665830015, 4476.283794592915, 4514.548545145459, 4517.096580683877, 4522.095580883836, 4545.36364908913, 4862.9544647900875, 4982.402111746541, 5203.973980130151, 5207.29701490294, 5215.895682086337, 4377.037051848588, 4402.933955990663, 4471.374007638933, 4472.530384309601, 4529.343245229424, 4532.116237333688, 4537.6143027843, 4538.909221815546, 4538.954610453853, 4574.6340292776495, 4602.516735742699, 4721.929171062368, 4895.31465594817, 4895.877603059952, 4911.066897289504, 4939.036887806987, 5090.389153301628, 5208.619715775247, 5242.266082748342, 5244.685318880879, 4787.54518320759, 4792.880177995578, 4796.66423350376, 4801.51984801517, 4829.613630909589, 4741.715497070187, 4976.303317535476, 4982.850514484571, 4985.252212168204, 5021.824236151717, 4984.22744474607, 4998.500149984972, 5052.46949070357, 5171.224316352577, 5223.660462069954, 4945.975270123627, 4946.530079642428, 4950.975245123751, 4953.777080031479, 5004.374453193351, 4711.952880471152, 4967.602591792575, 4981.028699403581, 4989.625778066587, 5001.624878134082, 4813.302071199727, 4834.6374021947795, 4836.782344794422, 4871.2206047032305, 4892.706437613754, 5013.24801279811, 5104.259882317117, 5112.923306150336, 5123.87190320245, 5158.277841102174, 4558.840440584564, 4930.852074437773, 4947.6536642434685, 4955.1823949048, 4991.376077990251], "unit": "ms", "name": "dojo.html", "value": 4667.309261115089}, {"lowerIsBetter": false, "replicates": [538.2598926476093, 558.5782734035803, 558.7904535799076, 574.259205624744, 579.2296245992829, 28142.43715125699, 28730.0, 37228.069298267554, 38178.0, 38297.0, 40295.39556906649, 40824.75463849487, 40906.795466022704, 40967.590324096825, 41073.56242531512, 6926.445884329241, 7807.804804879881, 7957.283844453998, 7959.880601790977, 7965.044194696645, 6968.756093536727, 10248.795024099514, 10520.0, 10524.421156836372, 10532.47337633119, 10159.644412445567, 10253.897461025406, 10262.435566043865, 10264.794704105914, 10266.845997310047, 7077.681504332266, 7225.313595208447, 10153.441560714158, 10274.280800343942, 10341.431221282826, 9749.610015599368, 9751.17115045222, 9778.462184579845, 9857.309988300822, 9871.309008369417, 37313.440298395544, 37357.25285494302, 37540.624593753986, 38258.80870595657, 38350.80824595859, 2341.7658234176615, 2570.5887058070807, 2873.827570345786, 2880.4095160492047, 2893.667228268755, 26924.192274231806, 27257.86371068132, 27560.586591201147, 27719.0, 28137.155885323475, 2942.602748628929, 2942.7057294270403, 2959.6300462442196, 3059.4187104450084, 3059.816411015324, 190769.0, 191518.0, 191864.0, 191882.0, 192998.0, 43912.780436097615, 44841.77579112084, 44843.32735008912, 44869.775651121534, 44922.55077449249, 63698.68150659217, 63992.36007639957, 64579.354206457334, 64581.67709161518, 64604.35395646077, 11844.111691622991, 11864.288142711464, 12103.636890893287, 12126.636200913987, 12133.15067945253, 8585.399022068521, 8605.397622166514, 8678.958524976917, 8918.286537077018, 8978.281737460988, 18135.909320453313, 18370.0, 18374.53003759696, 18425.815741842678, 18459.723104153447, 7371.9262807372315, 7385.6307184640555, 7591.620418979029, 7608.695652173851, 7610.8097297568, 818.5457071325352, 857.2584714222153, 918.136951265808, 961.8461046232709, 1003.7540802503287, 26428.33929151748, 26496.205113846616, 26661.200163995112, 26695.33261668474, 26761.732382676313, 870.8824308718368, 899.7975455522586, 914.0767824497306, 926.282131348197, 932.244881645869, 14234.572962811133, 14610.196439195946, 14725.55823325302, 14888.404463821542, 14939.626509337353, 247651.0, 251356.0, 251495.0, 251906.0, 252024.0, 46278.76860615743, 46451.53548464472, 46503.76748116238, 46648.5335146651, 46781.29828052582, 1086.1528008153496, 1097.1771171621283, 1113.3041848844473, 1114.7770445910687, 1282.307553920891, 25920.977475351574, 26376.472470550867, 26405.471890562465, 26462.338441539116, 26754.331141721614, 39109.608903910594, 39552.80223598864, 39557.0, 39598.60401395949, 39762.801185993885, 240196.0, 242100.0, 242334.0, 243468.0, 244883.0, 23879.52240955206, 24299.39251518726, 27906.302342441602, 28359.291017723895, 28739.28151796222, 32773.836130819196, 32929.01212963615, 38385.808070960586, 38669.6133038666, 39548.0, 29698.0, 29842.850785745934, 30022.69977300199, 30812.22969425782, 31024.689753103085, 30790.0, 31351.84324078365, 32357.191070223435, 32658.0, 32830.0, 27189.59215611807, 27685.169444916686, 32277.677223227467, 33028.1742956428, 33501.0, 26854.328641784112, 29398.26504337323, 29821.85089074541, 30104.247393814454, 30485.54271685882, 22794.202202922817, 23176.3047108587, 23288.301350959497, 23354.299371018897, 23391.0], "unit": "ms", "name": "ext.html", "value": 16562.7627026022}, {"lowerIsBetter": false, "replicates": [305.67598345753504, 310.07597359867594, 311.122634171636, 311.2467827856587, 314.0734832244877, 11607.941960290187, 12115.27308361499, 13885.500609890229, 14894.851051489482, 15311.464098756545, 11798.410079496034, 14346.497872574462, 14463.927680361583, 14862.47981320654, 14872.182029988346, 3651.214988777412, 4561.749103799298, 4713.952860471403, 4748.97625511872, 4792.089502994438, 4920.606351491872, 4976.427710813248, 4981.975090124544, 4983.9252411213865, 4984.127777638917, 4375.540568240337, 4934.333864928242, 4935.210366341386, 4936.925946110811, 4938.2098864181735, 4431.512533621299, 4453.109378124388, 4454.398656181406, 4456.3315502674695, 4457.977710111461, 3744.3821769408014, 3847.61523847613, 3849.8267577958777, 3851.9807400963095, 3904.531456225271, 11877.0, 12099.697507562381, 12106.455209515505, 12151.0, 12153.817692734616, 1667.7415000674914, 1674.5980964568537, 1702.0553592756016, 1702.7105392083377, 1723.1212081838353, 9120.087991200893, 9235.907640923571, 9249.583768730356, 9358.157765801043, 9370.95314523423, 1595.9521214363588, 1603.7514185301297, 1609.4688752711577, 1632.6244963658307, 1653.1568899861156, 52615.73692131553, 53062.46937530652, 53607.73196134033, 53992.460075399526, 54550.454495454935, 6287.402696743802, 6375.3624637536805, 6391.712372943229, 6399.8080057598345, 6493.642849643315, 7116.430685545144, 7177.856442871113, 7269.3094156055095, 7271.2365201653065, 7306.123265208103, 4705.4588722296685, 4719.10337035962, 4759.190937540627, 4769.070031343855, 4776.164171270014, 4854.417469903564, 4903.26451032348, 4905.337779399807, 4944.208926571731, 4950.702957822542, 2962.4963756161505, 2964.0663191094736, 3016.834074125944, 3030.848457577112, 3033.9544906826413, 1030.6032177611673, 1031.4997226345367, 1031.515187861704, 1033.395463653756, 1073.903348698621, 362.20857426523133, 379.7607507270402, 393.2018003452995, 394.26863168821995, 413.65459841032475, 10461.215408844368, 10598.576056957789, 10723.571057157626, 10827.458627068616, 10912.836307455394, 354.65598369581465, 400.3294481743069, 409.92006558720766, 412.03583614341983, 419.56365380005064, 5665.206871038058, 5696.850452681858, 5840.766369345179, 6094.329623741385, 6195.31851496335, 485267.0, 486296.0, 491749.0, 495353.0, 496997.0, 65163.348366515726, 68196.0, 68248.6587567059, 68303.3169668307, 68397.0, 448.04342728275367, 457.0516178928736, 458.55749202019547, 459.57489322376665, 460.2153328574839, 8404.705835295736, 9829.901700983184, 9926.553305101143, 9950.10449059588, 10017.949910250401, 30745.846270768503, 31326.0, 31662.841685792344, 32210.19474513156, 32269.838650806596, 38418.615813841505, 40329.0, 40377.99055023648, 40492.1901561973, 40546.18907621772, 5922.851928701817, 5955.374685657944, 6032.155498230163, 6032.939670603238, 6193.659348735863, 11151.944240278746, 11392.48733806964, 11426.828597570877, 11529.250598711056, 11647.893450122225, 9823.36148150368, 9981.151602113901, 9989.850152247867, 10363.170946324426, 10368.429736364573, 9540.0, 9669.613215471583, 9761.267904907018, 9822.410655360702, 9831.606735730777, 9736.782902137233, 9786.727725395653, 9839.901600984185, 9928.553215105194, 9973.650922217688, 5169.767360468863, 5260.842174734764, 5282.181261904411, 5691.686957217393, 5858.677772722371, 9277.443353398818, 9449.102335278412, 9689.563969621526, 9698.806023879624, 9737.513124343895], "unit": "ms", "name": "jquery.html", "value": 6223.34660432896}, {"lowerIsBetter": false, "replicates": [1392.7214557088573, 1591.761235814628, 1643.0552432351394, 1665.2339923635127, 1665.5836040989752, 5708.800191993281, 6390.233172019359, 6460.483161347092, 6519.054737063123, 6529.2817790043055, 6206.0, 6617.470602351812, 6626.436752875999, 6627.138471998645, 6637.269900310962, 1919.9040047997614, 1977.1399441243034, 1987.2249822569138, 1989.6816509358505, 1994.2621230144866, 1966.6263409952135, 2002.5594369238818, 2011.3362590345223, 2031.7460317460318, 2035.4707775978204, 1989.7811240763576, 2008.8192062714352, 2028.6449871272541, 2033.8305474352233, 2034.6744520876662, 1951.2292644405452, 1960.725498430221, 1964.0, 1967.9409617711349, 1970.5467742419323, 1971.9802801972085, 1988.0556735550642, 1991.1139542903413, 2017.6872584749387, 2018.1826360324092, 5502.312210973629, 5705.343885453184, 6661.566998145105, 6713.93286067138, 6725.730970761164, 3482.286131343094, 3539.3983022886173, 3551.3607550640872, 3886.844526218948, 3976.363781794928, 2677.6385187999567, 2693.7844972402163, 2701.6757989041243, 2738.835669859815, 2743.478739039576, 874.1782724239195, 874.6020560644955, 876.6493402638931, 894.9418287811271, 900.9909900900973, 8732.563371831446, 8830.602622881986, 8833.514156721378, 8847.071057538995, 8860.778480537974, 3748.0, 3759.6240375962184, 3765.548134223911, 3811.9809400953372, 3819.52255968004, 7862.882056769153, 7864.764057078297, 7866.646000929972, 7867.567283799446, 7903.446758726949, 4114.938275925863, 4124.938125928114, 4137.648299894482, 4138.503379594468, 4141.79291035447, 3652.36083685354, 3658.268346330691, 3663.5420572428447, 3688.741788074809, 3763.9247215055548, 3124.5313203019273, 3127.46833038384, 3138.356636889432, 3170.2074481379655, 3175.8249447704034, 960.0351646595267, 962.2879069488667, 965.560669895196, 972.1979367022235, 997.5660587644398, 1116.1851848150734, 1128.8081026225561, 1137.2778285788584, 1147.1683029803326, 1149.224273615323, 6312.0, 6348.904766428507, 6360.0, 6362.981922892408, 6413.358664133642, 346.6862489447004, 350.617826569041, 351.26760703932587, 351.542994107659, 352.3376053020357, 4388.846390376385, 4747.548982846624, 4858.198397264412, 4874.561289483963, 4875.780589873464, 6589.769358072444, 8101.675932962733, 8126.821610866509, 8130.75607731769, 8138.877916831252, 7942.927704759783, 8018.639161237758, 8029.277365037175, 8029.678812847421, 8034.437589368688, 6111.35830737775, 6291.6854157291955, 6305.274893387227, 6408.967955160194, 6449.7420103195345, 6322.841928951813, 6338.90491642635, 6339.96830015847, 6346.492280617632, 6359.395857393541, 7112.857742845217, 7173.282671732785, 7186.065811444479, 7276.126864776261, 7295.197528271992, 6770.45836333102, 6977.0, 6984.860302794017, 7005.369516743517, 7457.440691948234, 5981.730822112929, 5987.161797348462, 6068.120122582289, 6079.726412311368, 6082.36135205797, 6402.391772781578, 6445.516586255956, 6462.127612772404, 6508.349165083454, 6510.121133647087, 6008.519318454426, 6052.485538729257, 6115.205023346936, 6216.72024758896, 6249.593776404519, 5978.551608629457, 6034.456898879122, 6101.481374083075, 6129.295131059986, 6141.47797437205, 5968.850778730566, 6088.238970128734, 6106.908396374147, 6115.235595550556, 6118.235220597426, 5544.251526043932, 5590.161475778666, 5604.103343465026, 5658.660480371191, 5704.486596206195, 5708.914366284426, 5714.885702285847, 5763.6541807491685, 5788.797392091256, 5799.449052340021], "unit": "ms", "name": "mootools.html", "value": 3779.7150467844626}, {"lowerIsBetter": false, "replicates": [284.5205828179517, 287.547113296558, 289.1354849001485, 293.3970690231573, 295.0073004340395, 5420.457954204578, 5428.701421421821, 5475.4524547545225, 5502.58730595206, 5504.807331743395, 5152.536271735543, 5246.580273578114, 5292.814751483699, 5415.377231618365, 5432.565394768419, 4130.834766609347, 4138.172365526892, 4138.689598280126, 4146.792660366985, 4148.937765933513, 3940.80295985201, 4141.461609990697, 4143.094176678732, 4152.231837110145, 4159.480064991876, 3889.7082718796064, 3892.0, 3968.0675041365257, 3990.8603198888045, 4020.5778393268724, 4020.718549701522, 4020.8994775130564, 4024.416459613369, 4031.3952907064026, 4044.1305119399176, 3502.5096486491657, 3512.227309991798, 3517.876874309387, 3526.770759900598, 3528.1708798432346, 5067.214581739836, 5073.162928116856, 5096.694198348111, 5116.232565115262, 5118.436971933084, 4563.794629241692, 4674.345591617176, 4698.718076915362, 4699.882502937419, 4703.035877645075, 5587.05020146576, 5588.161775733632, 5591.524720398771, 5594.860128496779, 5595.160725891108, 3856.9614303856883, 3860.575336712959, 3861.2663593917346, 3867.149227170018, 3871.380579107329, 5879.588428809985, 5891.440313170285, 5898.557608179361, 5900.321463031763, 5909.674967876722, 3957.6438120569287, 4031.9395209071886, 4057.1479989202007, 4057.229126465962, 4065.329220678555, 4117.2588933992165, 4117.855875044359, 4121.670266378683, 4124.566920473367, 4130.855420060344, 4764.666473346832, 4773.355596994361, 4774.045190961821, 4775.0, 4779.330893674888, 5712.65724056558, 5738.512226460714, 5748.683822389725, 5750.827475175752, 5757.136429535603, 1440.9495667651581, 1455.9417623294948, 1461.3862177885314, 1467.8238611366492, 1470.8382077971414, 938.5448057692014, 973.3478569358547, 977.6871401151564, 984.8178087053918, 985.7387792235063, 5052.242163675478, 5052.520010598987, 5054.7472626368535, 5057.266696329012, 5067.315912351859, 5936.28764548257, 5936.5844390892225, 5937.821865344046, 5940.584159108907, 5945.078512830518, 4891.461939186686, 4966.602671786249, 5038.2190760432195, 5057.949420505748, 5060.898782024339, 3156.952645710316, 3186.8725250990165, 3200.1839530919465, 3233.531137984979, 3238.5627940228237, 5579.665220086727, 5585.916211256835, 5592.664440133605, 5596.412376700469, 5602.327720673464, 5960.254968128984, 6099.939000610026, 6103.450689437972, 6106.175666285084, 6111.0, 5580.358258800209, 5604.467575580314, 5610.803621873215, 5613.663180209201, 5618.353889302701, 5915.08316210988, 5927.555433342431, 5928.733207005781, 5931.940680593311, 5932.317783454958, 5784.132380143013, 5798.478136967693, 5803.158542011469, 5805.796797112081, 5808.39011903744, 5479.53423958952, 5594.664320140804, 5595.300587426572, 5606.299212598426, 5607.607467477401, 4040.252553277653, 4052.412400202013, 4054.2499637567144, 4057.1682805024307, 4057.188562287495, 5911.290645122441, 5913.0, 5919.141724450017, 5920.141579470866, 5920.911186332122, 5604.719764011865, 5683.829485115453, 5695.117256825199, 5725.141228815711, 5741.311042674905, 5720.656760594377, 5738.8278351649515, 5741.45456181662, 5744.080947048452, 5747.798827041033, 5608.383077861514, 5612.7754889803955, 5614.333191733894, 5616.85957851057, 5625.268715067179, 5757.453041961007, 5763.337216220189, 5781.988152073286, 5804.796832110856, 5813.476787089182, 5500.80747173863, 5598.300212473441, 5626.24045753818, 5628.324601047901, 5633.126865335879], "unit": "ms", "name": "prototype.html", "value": 4242.731870975996}, {"lowerIsBetter": false, "replicates": [652.8335274505, 710.7299226294008, 760.646299470746, 777.7433446962503, 788.2393490281879, 11224.214304998653, 11388.430578471063, 11433.085353171726, 11458.7135321617, 11460.025897798687, 10595.152387808976, 10606.575736970532, 10686.839697404544, 10699.304545204557, 10701.83947240792, 764.5794812852937, 794.1661255681511, 799.9520028798262, 799.952002879829, 800.2677550041705, 772.4862966127519, 792.3819420851745, 792.8771040488733, 795.7016118955391, 797.2306724011328, 807.1605530248535, 830.0620299062051, 833.7248707926369, 833.7415401225609, 833.8415701016787, 808.0747544062075, 809.3323008517967, 818.4025661267308, 824.0276473760989, 824.2993455562784, 592.6562593695646, 596.6599038548029, 605.4581149870885, 605.8273392083279, 605.8333958161497, 10564.841527377095, 10566.9471652642, 10584.259101862872, 10622.57509699611, 10665.733356666145, 8989.146031127033, 9198.356115071947, 9360.53197340137, 9815.263855210887, 10159.187265018782, 8703.869441958375, 8764.8685269721, 8775.341849361323, 8790.340724445692, 8884.2892568595, 3172.1752344390625, 3181.984090079558, 3242.9837850810595, 3268.444364458048, 3319.2697606526526, 36855.0, 37605.43591846125, 38288.234235315416, 39118.80440597807, 41064.0, 9289.721308360626, 9401.811963760687, 9500.097490738368, 9550.570224339921, 9560.90439095614, 16119.032858028555, 16139.838601614068, 16159.0, 16170.919145404432, 16228.432004879773, 5904.202932604129, 5916.585838991229, 6056.697165141725, 6195.690215489298, 6222.502199824004, 3409.7272218222483, 3512.051746028558, 3532.346515894568, 3537.8231088445473, 3545.62770909056, 2772.5148099082985, 2803.7897157713255, 2809.9438011239663, 2810.8172968757376, 2811.1988083396136, 405.5944055944056, 416.26736942979966, 417.2989377845249, 419.40235164889907, 425.37045173143304, 491.9434265059492, 501.2456253338702, 566.8724536979229, 580.3471095018105, 607.8662694207268, 7804.648790804427, 8161.469504482189, 8750.0, 8815.735527934172, 9064.138906803842, 421.0799403303791, 421.6277205380227, 443.36598663910917, 565.2341077839468, 590.2356448399333, 3743.401055831054, 3870.670992965573, 3894.415837624322, 3905.082305658168, 3914.4911161548816, 54747.45252547503, 55888.0, 56183.71908140433, 56317.71841140768, 56396.43603563994, 48984.0, 49024.754876225394, 49346.50653493419, 49416.0, 49430.0, 35101.64898351035, 36389.81805091011, 36460.45309320362, 39449.80275098606, 40550.79724601358, 8239.917600823916, 8301.418900676894, 8461.830763384574, 8509.87235191485, 9019.774505637411, 31729.5240571387, 32583.0, 32834.67165328316, 32930.0, 32949.670503295616, 34157.829210853786, 34669.30661386708, 35844.820775895954, 41004.589954100076, 41495.377569337084, 6522.445592124533, 6773.254941956479, 6900.9654951726925, 6927.965360173167, 7207.207207207308, 11083.334999900031, 11554.133439992202, 11557.30656160633, 11716.472758726048, 11924.642260732191, 10065.949670251603, 10070.748231294276, 10270.897291026995, 10829.346810031593, 10939.671809845717, 10762.3542587445, 11128.44357782124, 11286.604968826052, 11308.0, 11583.5945741902, 10314.756508179324, 10462.372257664565, 10791.190660700322, 10930.45347732626, 11098.2786118902, 9466.432014079177, 9625.56684949193, 9650.613975441185, 9684.56419461112, 9890.060444257784, 9042.803328432828, 9100.247629161746, 9267.629294828132, 9318.580663870278, 9346.345755797029], "unit": "ms", "name": "yui.html", "value": 5591.436423480858}], "name": "dromaeo_css", "value": 5922.193050519367}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 109.0, 114.0, 114.0, 114.0, 124.0, 115.0, 114.0, 114.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.6}, {"lowerIsBetter": true, "replicates": [154.0, 131.0, 153.0, 170.0, 133.0, 160.0, 155.0, 141.0, 180.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.8}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 162.0, 165.0, 160.0, 163.0, 162.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 82.0, 92.0, 73.0, 73.0, 73.0, 96.0, 93.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [93.0, 93.0, 139.0, 92.0, 92.0, 92.0, 125.0, 92.0, 93.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 103.8}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [149.0, 149.0, 148.0, 150.0, 148.0, 148.0, 148.0, 148.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 75.0, 74.0, 73.0, 73.0, 73.0, 81.0, 70.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 69.0, 70.0, 70.0, 69.0, 71.0, 70.0, 71.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.9}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 88.0, 84.0, 85.0, 83.0, 84.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.9}, {"lowerIsBetter": true, "replicates": [127.0, 121.0, 130.0, 122.0, 135.0, 121.0, 122.0, 123.0, 121.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.4}, {"lowerIsBetter": true, "replicates": [147.0, 145.0, 155.0, 156.0, 144.0, 141.0, 157.0, 152.0, 153.0, 146.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 149.6}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 71.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1538.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.99918500407497], "unit": "score", "name": "Richards", "value": 216.57777000000004}, {"lowerIsBetter": false, "replicates": [186.3238308179616], "unit": "score", "name": "DeltaBlue", "value": 354.85530600000016}, {"lowerIsBetter": false, "replicates": [280.97780275358247], "unit": "score", "name": "Encrypt", "value": 947.3381789999996}, {"lowerIsBetter": false, "replicates": [5025.125628140703], "unit": "score", "name": "Decrypt", "value": 52.970019}, {"lowerIsBetter": false, "replicates": [2018.1451612903227], "unit": "score", "name": "RayTrace", "value": 366.667876123876}, {"lowerIsBetter": false, "replicates": [796.8127490039841], "unit": "score", "name": "Earley", "value": 836.4110649999999}, {"lowerIsBetter": false, "replicates": [12180.722891566265], "unit": "score", "name": "Boyer", "value": 54.714568743818035}, {"lowerIsBetter": false, "replicates": [27108.108108108107], "unit": "score", "name": "RegExp", "value": 33.60562811565303}, {"lowerIsBetter": false, "replicates": [605.294825511432], "unit": "score", "name": "Splay", "value": 134.63026043737577}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19811.124633000763}]} 18:44:24 INFO - RETURN: dromaeo_css: 5922.20 18:44:24 INFO - RETURN: kraken: 1538.50 18:44:24 INFO - RETURN: v8_7: 19811.12 18:44:24 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19811.12"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1538.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "5922.20"}}} 18:44:24 INFO - Return code: 0 18:44:24 INFO - # TBPL SUCCESS # 18:44:24 INFO - Running post-action listener: _resource_record_post_action 18:44:24 INFO - Running post-run listener: _resource_record_post_run 18:44:25 INFO - Total resource usage - Wall time: 1239s; CPU: 13.0%; Read bytes: 10326016; Write bytes: 402251776; Read time: 4124; Write time: 496188 18:44:25 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 4460544; Read time: 0; Write time: 352 18:44:25 INFO - run-tests - Wall time: 1225s; CPU: 13.0%; Read bytes: 8065024; Write bytes: 397791232; Read time: 3848; Write time: 495836 18:44:25 INFO - Running post-run listener: _upload_blobber_files 18:44:25 INFO - Blob upload gear active. 18:44:25 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 18:44:25 INFO - Copying logs to upload dir... 18:44:25 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1278.599294 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 18 secs) (at 2015-11-17 18:44:25.357618) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:44:25.362119) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009913 build_url: 'https://queue.taskcluster.net/v1/task/enpMD1-uRKiAbFuPpt133Q/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 18:44:25.413805) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:44:25.414124) ========= 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=0ae9de487587ba4b94dd3100000001b5-1447806223.707245-55631719 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004580 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 18:44:25.463707) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:44:25.464030) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 18:44:25.464562) ========= ========= Total master_lag: 0.22 =========