builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-051 starttime: 1450311633.66 results: success (0) buildid: 20151216155559 builduid: 70d826cc5c594eca94f67fe2d81553b8 revision: 31c4e5dbd4c3775df883c787988261f979925f6a ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.655593) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.656245) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.656587) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006322 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.690786) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.691093) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.718432) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.718749) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.771872) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.772170) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.772546) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:33.772850) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-16 16:20:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 46.8M=0s 2015-12-16 16:20:34 (46.8 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.210561 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.000352) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.000709) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015154 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.057905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.058270) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 31c4e5dbd4c3775df883c787988261f979925f6a --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 31c4e5dbd4c3775df883c787988261f979925f6a --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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-16 16:20:34,382 truncating revision to first 12 chars 2015-12-16 16:20:34,382 Setting DEBUG logging. 2015-12-16 16:20:34,382 attempt 1/10 2015-12-16 16:20:34,382 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/31c4e5dbd4c3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-16 16:20:34,631 unpacking tar archive at: fx-team-31c4e5dbd4c3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527574 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.601159) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.601636) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.613573) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.613959) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-16 16:20:34.614931) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 16:20:34.615440) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-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', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:20:35 INFO - MultiFileLogger online at 20151216 16:20:35 in /builds/slave/test 16:20:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 16:20:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:20:35 INFO - {'append_to_log': False, 16:20:35 INFO - 'base_work_dir': '/builds/slave/test', 16:20:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 16:20:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:20:35 INFO - 'branch': 'Fx-Team-Non-PGO', 16:20:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:20:35 INFO - 'config_files': ('talos/linux_config.py',), 16:20:35 INFO - 'default_actions': ('clobber', 16:20:35 INFO - 'read-buildbot-config', 16:20:35 INFO - 'download-and-extract', 16:20:35 INFO - 'populate-webroot', 16:20:35 INFO - 'create-virtualenv', 16:20:35 INFO - 'install', 16:20:35 INFO - 'run-tests'), 16:20:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:20:35 INFO - 'download_minidump_stackwalk': True, 16:20:35 INFO - 'download_symbols': 'ondemand', 16:20:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:20:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:20:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:20:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:20:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:20:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:20:35 INFO - 'installer_path': 'installer.exe', 16:20:35 INFO - 'log_level': 'info', 16:20:35 INFO - 'log_name': 'talos', 16:20:35 INFO - 'log_to_console': True, 16:20:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:20:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:20:35 INFO - 'opt_config_files': (), 16:20:35 INFO - 'pip_index': False, 16:20:35 INFO - 'sps_profile': False, 16:20:35 INFO - 'sps_profile_interval': 0, 16:20:35 INFO - 'suite': 'dromaeojs', 16:20:35 INFO - 'system_bits': '64', 16:20:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:20:35 INFO - 'title': 'talos-linux64-ix-051', 16:20:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:20:35 INFO - 'use_talos_json': True, 16:20:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:20:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:20:35 INFO - 'work_dir': 'build'} 16:20:35 INFO - ##### 16:20:35 INFO - ##### Running clobber step. 16:20:35 INFO - ##### 16:20:35 INFO - Running pre-action listener: _resource_record_pre_action 16:20:35 INFO - Running main action method: clobber 16:20:35 INFO - rmtree: /builds/slave/test/build 16:20:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:20:35 INFO - Running post-action listener: _resource_record_post_action 16:20:35 INFO - ##### 16:20:35 INFO - ##### Running read-buildbot-config step. 16:20:35 INFO - ##### 16:20:35 INFO - Running pre-action listener: _resource_record_pre_action 16:20:35 INFO - Running main action method: read_buildbot_config 16:20:35 INFO - Using buildbot properties: 16:20:35 INFO - { 16:20:35 INFO - "project": "", 16:20:35 INFO - "product": "firefox", 16:20:35 INFO - "script_repo_revision": "production", 16:20:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 16:20:35 INFO - "repository": "", 16:20:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 16:20:35 INFO - "buildid": "20151216155559", 16:20:35 INFO - "pgo_build": "False", 16:20:35 INFO - "basedir": "/builds/slave/test", 16:20:35 INFO - "buildnumber": 1018, 16:20:35 INFO - "slavename": "talos-linux64-ix-051", 16:20:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:20:35 INFO - "platform": "ubuntu64_hw", 16:20:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 16:20:35 INFO - "branch": "fx-team", 16:20:35 INFO - "repo_path": "integration/fx-team", 16:20:35 INFO - "revision": "31c4e5dbd4c3775df883c787988261f979925f6a", 16:20:35 INFO - "stage_platform": "linux64", 16:20:35 INFO - "builduid": "70d826cc5c594eca94f67fe2d81553b8", 16:20:35 INFO - "slavebuilddir": "test" 16:20:35 INFO - } 16:20:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 16:20:35 INFO - Running post-action listener: _resource_record_post_action 16:20:35 INFO - ##### 16:20:35 INFO - ##### Running download-and-extract step. 16:20:35 INFO - ##### 16:20:35 INFO - Running pre-action listener: _resource_record_pre_action 16:20:35 INFO - Running main action method: download_and_extract 16:20:35 INFO - mkdir: /builds/slave/test/build/tests 16:20:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:35 INFO - https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:20:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/test_packages.json 16:20:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/test_packages.json 16:20:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:20:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:20:40 INFO - Downloaded 1302 bytes. 16:20:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:20:40 INFO - Using the following test package requirements: 16:20:40 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:40 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:20:40 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'jsshell-linux-x86_64.zip'], 16:20:40 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:20:40 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:40 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:20:40 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:20:40 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:20:40 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 16:20:40 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 16:20:40 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:20:40 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:20: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')]} 16:20:40 INFO - https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:20:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:20:42 INFO - Downloaded 21869235 bytes. 16:20:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:20:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:20:43 INFO - Return code: 0 16:20:43 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 16:20:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:43 INFO - https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:20:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 16:20:45 INFO - Downloaded 21869235 bytes. 16:20:45 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 16:20:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 16:20:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 16:20:46 INFO - Return code: 0 16:20:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:46 INFO - https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:20:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:20:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:20:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:20:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 16:20:47 INFO - Downloaded 11132052 bytes. 16:20:47 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 16:20:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 16:20:47 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 16:20:47 INFO - Return code: 0 16:20:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:47 INFO - https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:20:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:20:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:20:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:20:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 16:20:49 INFO - Downloaded 57770807 bytes. 16:20:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:20:49 INFO - mkdir: /builds/slave/test/properties 16:20:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:20:49 INFO - Writing to file /builds/slave/test/properties/build_url 16:20:49 INFO - Contents: 16:20:49 INFO - build_url:https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 16:20:49 INFO - Running post-action listener: _resource_record_post_action 16:20:49 INFO - Running post-action listener: set_extra_try_arguments 16:20:49 INFO - ##### 16:20:49 INFO - ##### Running populate-webroot step. 16:20:49 INFO - ##### 16:20:49 INFO - Running pre-action listener: _resource_record_pre_action 16:20:49 INFO - Running main action method: populate_webroot 16:20:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:20:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:20:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:20:49 INFO - '--tppagecycles', 16:20:49 INFO - '7'], 16:20:49 INFO - 'tests': ['tsvgm']}}, 16:20:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:20:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:20:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:20:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:20:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:20:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'tests': ['damp', 'tps']}, 16:20:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['damp', 'tps']}, 16:20:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:20:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:20:49 INFO - 'other': {'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'other_l64': {'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'other_nol64': {'tests': ['a11yr', 16:20:49 INFO - 'ts_paint', 16:20:49 INFO - 'tpaint', 16:20:49 INFO - 'sessionrestore', 16:20:49 INFO - 'sessionrestore_no_auto_restore']}, 16:20:49 INFO - 'svgr': {'tests': ['tsvgx', 16:20:49 INFO - 'tsvgr_opacity', 16:20:49 INFO - 'tart', 16:20:49 INFO - 'tscrollx', 16:20:49 INFO - 'cart']}, 16:20:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['tsvgx', 16:20:49 INFO - 'tsvgr_opacity', 16:20:49 INFO - 'tart', 16:20:49 INFO - 'tscrollx', 16:20:49 INFO - 'cart']}, 16:20:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'tests': ['tp5o']}, 16:20:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'talos_options': ['--e10s'], 16:20:49 INFO - 'tests': ['tp5o']}, 16:20:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'talos_options': ['--xperf_path', 16:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:49 INFO - 'tests': ['tp5n']}, 16:20:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:20:49 INFO - 'talos_options': ['--e10s', 16:20:49 INFO - '--xperf_path', 16:20:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:20:49 INFO - 'tests': ['tp5n']}}, 16:20:49 INFO - 'talos.zip': {'path': '', 16:20:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:20:49 INFO - Running post-action listener: _resource_record_post_action 16:20:49 INFO - ##### 16:20:49 INFO - ##### Running create-virtualenv step. 16:20:49 INFO - ##### 16:20:49 INFO - Running pre-action listener: _resource_record_pre_action 16:20:49 INFO - Running main action method: create_virtualenv 16:20:49 INFO - Creating virtualenv /builds/slave/test/build/venv 16:20:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:20:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:20:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:20:49 INFO - Using real prefix '/usr' 16:20:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:20:50 INFO - Installing distribute.............................................................................................................................................................................................done. 16:20:52 INFO - Installing pip.................done. 16:20:52 INFO - Return code: 0 16:20:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:20:52 INFO - Using env: {'DISPLAY': ':0', 16:20:52 INFO - 'HOME': '/home/cltbld', 16:20:52 INFO - 'LANG': 'en_US.UTF-8', 16:20:52 INFO - 'LANGUAGE': 'en_US:en', 16:20:52 INFO - 'LOGNAME': 'cltbld', 16:20:52 INFO - 'MAIL': '/var/mail/cltbld', 16:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:52 INFO - 'MOZ_NO_REMOTE': '1', 16:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:52 INFO - 'NO_EM_RESTART': '1', 16:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:52 INFO - 'PWD': '/builds/slave/test', 16:20:52 INFO - 'SHELL': '/bin/bash', 16:20:52 INFO - 'SHLVL': '1', 16:20:52 INFO - 'TERM': 'linux', 16:20:52 INFO - 'TMOUT': '86400', 16:20:52 INFO - 'USER': 'cltbld', 16:20:52 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:52 INFO - '_': '/tools/buildbot/bin/python'} 16:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:20:52 INFO - Cleaning up... 16:20:52 INFO - Return code: 0 16:20:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:20:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:20:52 INFO - Using env: {'DISPLAY': ':0', 16:20:52 INFO - 'HOME': '/home/cltbld', 16:20:52 INFO - 'LANG': 'en_US.UTF-8', 16:20:52 INFO - 'LANGUAGE': 'en_US:en', 16:20:52 INFO - 'LOGNAME': 'cltbld', 16:20:52 INFO - 'MAIL': '/var/mail/cltbld', 16:20:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:52 INFO - 'MOZ_NO_REMOTE': '1', 16:20:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:52 INFO - 'NO_EM_RESTART': '1', 16:20:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:52 INFO - 'PWD': '/builds/slave/test', 16:20:52 INFO - 'SHELL': '/bin/bash', 16:20:52 INFO - 'SHLVL': '1', 16:20:52 INFO - 'TERM': 'linux', 16:20:52 INFO - 'TMOUT': '86400', 16:20:52 INFO - 'USER': 'cltbld', 16:20:52 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:20:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:52 INFO - '_': '/tools/buildbot/bin/python'} 16:20:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:52 INFO - Downloading/unpacking psutil>=0.7.1 16:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:20:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:20:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:54 INFO - Installing collected packages: psutil 16:20:54 INFO - Running setup.py install for psutil 16:20:54 INFO - building 'psutil._psutil_linux' extension 16:20:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 16:20:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 16:20:54 INFO - building 'psutil._psutil_posix' extension 16:20:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 16:20:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 16:20:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:20:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:20:54 INFO - Successfully installed psutil 16:20:54 INFO - Cleaning up... 16:20:54 INFO - Return code: 0 16:20:54 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:54 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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:54 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 16:20:54 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 16:20:54 INFO - Using env: {'DISPLAY': ':0', 16:20:54 INFO - 'HOME': '/home/cltbld', 16:20:54 INFO - 'LANG': 'en_US.UTF-8', 16:20:54 INFO - 'LANGUAGE': 'en_US:en', 16:20:54 INFO - 'LOGNAME': 'cltbld', 16:20:54 INFO - 'MAIL': '/var/mail/cltbld', 16:20:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:54 INFO - 'MOZ_NO_REMOTE': '1', 16:20:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:54 INFO - 'NO_EM_RESTART': '1', 16:20:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:54 INFO - 'PWD': '/builds/slave/test', 16:20:54 INFO - 'SHELL': '/bin/bash', 16:20:54 INFO - 'SHLVL': '1', 16:20:54 INFO - 'TERM': 'linux', 16:20:54 INFO - 'TMOUT': '86400', 16:20:54 INFO - 'USER': 'cltbld', 16:20:54 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:20:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:54 INFO - '_': '/tools/buildbot/bin/python'} 16:20:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:20:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:20:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:20:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:20:56 INFO - Installing collected packages: mozsystemmonitor 16:20:56 INFO - Running setup.py install for mozsystemmonitor 16:20:56 INFO - Successfully installed mozsystemmonitor 16:20:56 INFO - Cleaning up... 16:20:56 INFO - Return code: 0 16:20:56 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:20:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:20:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:20:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:20:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:20:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:20:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:20:56 INFO - Using env: {'DISPLAY': ':0', 16:20:56 INFO - 'HOME': '/home/cltbld', 16:20:56 INFO - 'LANG': 'en_US.UTF-8', 16:20:56 INFO - 'LANGUAGE': 'en_US:en', 16:20:56 INFO - 'LOGNAME': 'cltbld', 16:20:56 INFO - 'MAIL': '/var/mail/cltbld', 16:20:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:20:56 INFO - 'MOZ_NO_REMOTE': '1', 16:20:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:20:56 INFO - 'NO_EM_RESTART': '1', 16:20:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:20:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:20:56 INFO - 'PWD': '/builds/slave/test', 16:20:56 INFO - 'SHELL': '/bin/bash', 16:20:56 INFO - 'SHLVL': '1', 16:20:56 INFO - 'TERM': 'linux', 16:20:56 INFO - 'TMOUT': '86400', 16:20:56 INFO - 'USER': 'cltbld', 16:20:56 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:20:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:20:56 INFO - '_': '/tools/buildbot/bin/python'} 16:20:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:20:57 INFO - Downloading/unpacking blobuploader==1.2.4 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:58 INFO - Downloading blobuploader-1.2.4.tar.gz 16:20:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:20:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:20:58 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:20:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:20:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:20:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:20:59 INFO - Downloading docopt-0.6.1.tar.gz 16:20:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:20:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:20:59 INFO - Installing collected packages: blobuploader, requests, docopt 16:20:59 INFO - Running setup.py install for blobuploader 16:20:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:20:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:20:59 INFO - Running setup.py install for requests 16:21:00 INFO - Running setup.py install for docopt 16:21:00 INFO - Successfully installed blobuploader requests docopt 16:21:00 INFO - Cleaning up... 16:21:00 INFO - Return code: 0 16:21:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:00 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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:00 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 16:21:00 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 16:21:00 INFO - Using env: {'DISPLAY': ':0', 16:21:00 INFO - 'HOME': '/home/cltbld', 16:21:00 INFO - 'LANG': 'en_US.UTF-8', 16:21:00 INFO - 'LANGUAGE': 'en_US:en', 16:21:00 INFO - 'LOGNAME': 'cltbld', 16:21:00 INFO - 'MAIL': '/var/mail/cltbld', 16:21:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:00 INFO - 'MOZ_NO_REMOTE': '1', 16:21:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:00 INFO - 'NO_EM_RESTART': '1', 16:21:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:00 INFO - 'PWD': '/builds/slave/test', 16:21:00 INFO - 'SHELL': '/bin/bash', 16:21:00 INFO - 'SHLVL': '1', 16:21:00 INFO - 'TERM': 'linux', 16:21:00 INFO - 'TMOUT': '86400', 16:21:00 INFO - 'USER': 'cltbld', 16:21:00 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:00 INFO - '_': '/tools/buildbot/bin/python'} 16:21:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:00 INFO - Running setup.py (path:/tmp/pip-k6Xeme-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:00 INFO - Running setup.py (path:/tmp/pip-1lQcSf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:00 INFO - Running setup.py (path:/tmp/pip-OqqwHq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:00 INFO - Running setup.py (path:/tmp/pip-guQoWM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:00 INFO - Running setup.py (path:/tmp/pip-ts3kP3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:00 INFO - Running setup.py (path:/tmp/pip-I974CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:00 INFO - Running setup.py (path:/tmp/pip-B8LNFp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:00 INFO - Running setup.py (path:/tmp/pip-Ft1ml0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:00 INFO - Running setup.py (path:/tmp/pip-qxRN2B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:01 INFO - Running setup.py (path:/tmp/pip-AhBgmG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:01 INFO - Running setup.py (path:/tmp/pip-Nzf0LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:01 INFO - Running setup.py (path:/tmp/pip-6fQFIG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:01 INFO - Running setup.py (path:/tmp/pip-xsK_p8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:01 INFO - Running setup.py (path:/tmp/pip-zONHig-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:01 INFO - Running setup.py (path:/tmp/pip-OTQBl7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:01 INFO - Running setup.py (path:/tmp/pip-uouXoR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:01 INFO - Running setup.py (path:/tmp/pip-wlpLfR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:21:01 INFO - Running setup.py install for manifestparser 16:21:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:21:01 INFO - Running setup.py install for mozcrash 16:21:01 INFO - Running setup.py install for mozdebug 16:21:01 INFO - Running setup.py install for mozdevice 16:21:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozfile 16:21:02 INFO - Running setup.py install for mozhttpd 16:21:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozinfo 16:21:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozInstall 16:21:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozleak 16:21:02 INFO - Running setup.py install for mozlog 16:21:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for moznetwork 16:21:02 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozprocess 16:21:02 INFO - Running setup.py install for mozprofile 16:21:02 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:21:02 INFO - Running setup.py install for mozrunner 16:21:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:21:03 INFO - Running setup.py install for mozscreenshot 16:21:03 INFO - Running setup.py install for moztest 16:21:03 INFO - Running setup.py install for mozversion 16:21:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:21:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:21:03 INFO - Cleaning up... 16:21:03 INFO - Return code: 0 16:21:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:03 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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:03 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 16:21:03 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 16:21:03 INFO - Using env: {'DISPLAY': ':0', 16:21:03 INFO - 'HOME': '/home/cltbld', 16:21:03 INFO - 'LANG': 'en_US.UTF-8', 16:21:03 INFO - 'LANGUAGE': 'en_US:en', 16:21:03 INFO - 'LOGNAME': 'cltbld', 16:21:03 INFO - 'MAIL': '/var/mail/cltbld', 16:21:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:03 INFO - 'MOZ_NO_REMOTE': '1', 16:21:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:03 INFO - 'NO_EM_RESTART': '1', 16:21:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:03 INFO - 'PWD': '/builds/slave/test', 16:21:03 INFO - 'SHELL': '/bin/bash', 16:21:03 INFO - 'SHLVL': '1', 16:21:03 INFO - 'TERM': 'linux', 16:21:03 INFO - 'TMOUT': '86400', 16:21:03 INFO - 'USER': 'cltbld', 16:21:03 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:03 INFO - '_': '/tools/buildbot/bin/python'} 16:21:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Running setup.py (path:/tmp/pip-I4P6AK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 INFO - Running setup.py (path:/tmp/pip-fUVJi2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:21:03 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)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Running setup.py (path:/tmp/pip-EDq16f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 INFO - Running setup.py (path:/tmp/pip-zdbwZX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:21:03 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)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Running setup.py (path:/tmp/pip-0siiVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:21:03 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:21:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:21:03 INFO - Running setup.py (path:/tmp/pip-RJ7GXW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:21:04 INFO - Running setup.py (path:/tmp/pip-iyUlY0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:21:04 INFO - Running setup.py (path:/tmp/pip-zVxhRp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:21:04 INFO - Running setup.py (path:/tmp/pip-6ixOZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:21:04 INFO - Running setup.py (path:/tmp/pip-qhC_bH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:21:04 INFO - Running setup.py (path:/tmp/pip-_5E3F4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:21:04 INFO - Running setup.py (path:/tmp/pip-unpUTD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 INFO - Running setup.py (path:/tmp/pip-Iiqx38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:21:04 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)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Running setup.py (path:/tmp/pip-gQsWGC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Running setup.py (path:/tmp/pip-zwCKDM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Running setup.py (path:/tmp/pip-N3xaVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:21:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Running setup.py (path:/tmp/pip-QeTVIg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 16:21:04 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)) 16:21:04 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)) 16:21:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:21:04 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)) 16:21:04 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)) 16:21:04 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:06 INFO - Downloading blessings-1.5.1.tar.gz 16:21:06 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 16:21:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:21:06 INFO - Installing collected packages: blessings 16:21:06 INFO - Running setup.py install for blessings 16:21:06 INFO - Successfully installed blessings 16:21:06 INFO - Cleaning up... 16:21:06 INFO - Return code: 0 16:21:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:21:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:06 INFO - Reading from file tmpfile_stdout 16:21:06 INFO - Current package versions: 16:21:06 INFO - argparse == 1.2.1 16:21:06 INFO - blessings == 1.5.1 16:21:06 INFO - blobuploader == 1.2.4 16:21:06 INFO - docopt == 0.6.1 16:21:06 INFO - manifestparser == 1.1 16:21:06 INFO - mozInstall == 1.12 16:21:06 INFO - mozcrash == 0.16 16:21:06 INFO - mozdebug == 0.1 16:21:06 INFO - mozdevice == 0.47 16:21:06 INFO - mozfile == 1.2 16:21:06 INFO - mozhttpd == 0.7 16:21:06 INFO - mozinfo == 0.9 16:21:06 INFO - mozleak == 0.1 16:21:06 INFO - mozlog == 3.1 16:21:06 INFO - moznetwork == 0.27 16:21:06 INFO - mozprocess == 0.22 16:21:06 INFO - mozprofile == 0.27 16:21:06 INFO - mozrunner == 6.11 16:21:06 INFO - mozscreenshot == 0.1 16:21:06 INFO - mozsystemmonitor == 0.0 16:21:06 INFO - moztest == 0.7 16:21:06 INFO - mozversion == 1.4 16:21:06 INFO - psutil == 3.1.1 16:21:06 INFO - requests == 1.2.3 16:21:06 INFO - wsgiref == 0.1.2 16:21:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:06 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 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:06 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 16:21:06 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 16:21:06 INFO - Using env: {'DISPLAY': ':0', 16:21:06 INFO - 'HOME': '/home/cltbld', 16:21:06 INFO - 'LANG': 'en_US.UTF-8', 16:21:06 INFO - 'LANGUAGE': 'en_US:en', 16:21:06 INFO - 'LOGNAME': 'cltbld', 16:21:06 INFO - 'MAIL': '/var/mail/cltbld', 16:21:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:06 INFO - 'MOZ_NO_REMOTE': '1', 16:21:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:06 INFO - 'NO_EM_RESTART': '1', 16:21:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:06 INFO - 'PWD': '/builds/slave/test', 16:21:06 INFO - 'SHELL': '/bin/bash', 16:21:06 INFO - 'SHLVL': '1', 16:21:06 INFO - 'TERM': 'linux', 16:21:06 INFO - 'TMOUT': '86400', 16:21:06 INFO - 'USER': 'cltbld', 16:21:06 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:06 INFO - '_': '/tools/buildbot/bin/python'} 16:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 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)) 16:21:07 INFO - Cleaning up... 16:21:07 INFO - Return code: 0 16:21:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 16:21:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 16:21:07 INFO - Using env: {'DISPLAY': ':0', 16:21:07 INFO - 'HOME': '/home/cltbld', 16:21:07 INFO - 'LANG': 'en_US.UTF-8', 16:21:07 INFO - 'LANGUAGE': 'en_US:en', 16:21:07 INFO - 'LOGNAME': 'cltbld', 16:21:07 INFO - 'MAIL': '/var/mail/cltbld', 16:21:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:07 INFO - 'MOZ_NO_REMOTE': '1', 16:21:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:07 INFO - 'NO_EM_RESTART': '1', 16:21:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:07 INFO - 'PWD': '/builds/slave/test', 16:21:07 INFO - 'SHELL': '/bin/bash', 16:21:07 INFO - 'SHLVL': '1', 16:21:07 INFO - 'TERM': 'linux', 16:21:07 INFO - 'TMOUT': '86400', 16:21:07 INFO - 'USER': 'cltbld', 16:21:07 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:07 INFO - '_': '/tools/buildbot/bin/python'} 16:21:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:07 INFO - Downloading/unpacking jsonschema 16:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:21:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 16:21:09 INFO - Downloading/unpacking functools32 (from jsonschema) 16:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:09 INFO - Downloading functools32-3.2.3-2.tar.gz 16:21:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 16:21:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:21:09 INFO - warning: no files found matching '*.txt' 16:21:09 INFO - no previously-included directories found matching 'build' 16:21:09 INFO - no previously-included directories found matching 'dist' 16:21:09 INFO - no previously-included directories found matching '.git*' 16:21:09 INFO - Installing collected packages: jsonschema, functools32 16:21:09 INFO - Running setup.py install for functools32 16:21:09 INFO - warning: no files found matching '*.txt' 16:21:09 INFO - no previously-included directories found matching 'build' 16:21:09 INFO - no previously-included directories found matching 'dist' 16:21:09 INFO - no previously-included directories found matching '.git*' 16:21:09 INFO - Successfully installed jsonschema functools32 16:21:09 INFO - Cleaning up... 16:21:09 INFO - Return code: 0 16:21:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:21:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:21:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:21:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ac1ffbf10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22578a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2325240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, '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': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 16:21:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 16:21:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 16:21:09 INFO - Using env: {'DISPLAY': ':0', 16:21:09 INFO - 'HOME': '/home/cltbld', 16:21:09 INFO - 'LANG': 'en_US.UTF-8', 16:21:09 INFO - 'LANGUAGE': 'en_US:en', 16:21:09 INFO - 'LOGNAME': 'cltbld', 16:21:09 INFO - 'MAIL': '/var/mail/cltbld', 16:21:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:09 INFO - 'MOZ_NO_REMOTE': '1', 16:21:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:09 INFO - 'NO_EM_RESTART': '1', 16:21:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:09 INFO - 'PWD': '/builds/slave/test', 16:21:09 INFO - 'SHELL': '/bin/bash', 16:21:09 INFO - 'SHLVL': '1', 16:21:09 INFO - 'TERM': 'linux', 16:21:09 INFO - 'TMOUT': '86400', 16:21:09 INFO - 'USER': 'cltbld', 16:21:09 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:09 INFO - '_': '/tools/buildbot/bin/python'} 16:21:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:21:09 INFO - Downloading/unpacking flake8 16:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 16:21:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 16:21:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 16:21:11 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:21:11 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:21:11 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:21:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 16:21:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:21:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:21:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:21:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:21:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:21:12 INFO - no previously-included directories found matching 'docs/_build' 16:21:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:21:12 INFO - Running setup.py install for pep8 16:21:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:21:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:21:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:21:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:21:12 INFO - no previously-included directories found matching 'docs/_build' 16:21:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:21:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:21:12 INFO - Cleaning up... 16:21:12 INFO - Return code: 0 16:21:12 INFO - Running post-action listener: _resource_record_post_action 16:21:12 INFO - Running post-action listener: _start_resource_monitoring 16:21:12 INFO - Starting resource monitoring. 16:21:12 INFO - ##### 16:21:12 INFO - ##### Running install step. 16:21:12 INFO - ##### 16:21:12 INFO - Running pre-action listener: _resource_record_pre_action 16:21:12 INFO - Running main action method: install 16:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:21:12 INFO - Reading from file tmpfile_stdout 16:21:12 INFO - Detecting whether we're running mozinstall >=1.0... 16:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:21:12 INFO - Reading from file tmpfile_stdout 16:21:12 INFO - Output received: 16:21:12 INFO - Usage: mozinstall [options] installer 16:21:12 INFO - Options: 16:21:12 INFO - -h, --help show this help message and exit 16:21:12 INFO - -d DEST, --destination=DEST 16:21:12 INFO - Directory to install application into. [default: 16:21:12 INFO - "/builds/slave/test"] 16:21:12 INFO - --app=APP Application being installed. [default: firefox] 16:21:12 INFO - mkdir: /builds/slave/test/build/application 16:21:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 16:21:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 16:21:27 INFO - Reading from file tmpfile_stdout 16:21:27 INFO - Output received: 16:21:27 INFO - /builds/slave/test/build/application/firefox/firefox 16:21:27 INFO - Running post-action listener: _resource_record_post_action 16:21:27 INFO - ##### 16:21:27 INFO - ##### Running run-tests step. 16:21:27 INFO - ##### 16:21:27 INFO - Running pre-action listener: _resource_record_pre_action 16:21:27 INFO - Running main action method: run_tests 16:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:21:27 INFO - Python 2.7.3 16:21:27 INFO - Return code: 0 16:21:27 INFO - grabbing minidump binary from tooltool 16:21:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:21:27 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 0x23b40b0>, '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 0x23b4fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x23b5440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:21:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:21:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 16:21:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:21:27 INFO - Return code: 0 16:21:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:21:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:21:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:21:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:21:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:21:28 INFO - Return code: 0 16:21:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] in /builds/slave/test/build 16:21:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-051 --webServer localhost 16:21:28 INFO - Using env: {'DISPLAY': ':0', 16:21:28 INFO - 'HOME': '/home/cltbld', 16:21:28 INFO - 'LANG': 'en_US.UTF-8', 16:21:28 INFO - 'LANGUAGE': 'en_US:en', 16:21:28 INFO - 'LOGNAME': 'cltbld', 16:21:28 INFO - 'MAIL': '/var/mail/cltbld', 16:21:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:21:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:21:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:21:28 INFO - 'MOZ_NO_REMOTE': '1', 16:21:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:21:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:21:28 INFO - 'NO_EM_RESTART': '1', 16:21:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:21:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:21:28 INFO - 'PWD': '/builds/slave/test', 16:21:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:21:28 INFO - 'SHELL': '/bin/bash', 16:21:28 INFO - 'SHLVL': '1', 16:21:28 INFO - 'TERM': 'linux', 16:21:28 INFO - 'TMOUT': '86400', 16:21:28 INFO - 'USER': 'cltbld', 16:21:28 INFO - 'XDG_SESSION_COOKIE': 'd333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588', 16:21:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:21:28 INFO - '_': '/tools/buildbot/bin/python'} 16:21:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-051', '--webServer', 'localhost'] with output_timeout 3600 16:21:28 INFO - mozversion INFO | application_buildid: 20151216155559 16:21:28 INFO - mozversion INFO | application_changeset: 31c4e5dbd4c3775df883c787988261f979925f6a 16:21:28 INFO - mozversion INFO | application_display_name: Nightly 16:21:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:21:28 INFO - mozversion INFO | application_name: Firefox 16:21:28 INFO - mozversion INFO | application_remotingname: firefox 16:21:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:21:28 INFO - mozversion INFO | application_vendor: Mozilla 16:21:28 INFO - mozversion INFO | application_version: 46.0a1 16:21:28 INFO - mozversion INFO | platform_buildid: 20151216155559 16:21:28 INFO - mozversion INFO | platform_changeset: 31c4e5dbd4c3775df883c787988261f979925f6a 16:21:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:21:28 INFO - mozversion INFO | platform_version: 46.0a1 16:21:28 INFO - 2015-12-16 16:21:28,350 DEBUG : using testdate: 1450311688 16:21:28 INFO - 2015-12-16 16:21:28,350 DEBUG : actual date: 1450311688 16:21:28 INFO - 2015-12-16 16:21:28,358 INFO : starting webserver on 'localhost:59243' 16:21:28 INFO - 2015-12-16 16:21:28,359 INFO : Starting test suite talos-linux64-ix-051 16:21:28 INFO - 2015-12-16 16:21:28,359 INFO : Starting test dromaeo_css 16:21:28 INFO - 2015-12-16 16:21:28,359 DEBUG : operating with platform_type : linux_ 16:21:28 INFO - 2015-12-16 16:21:28,360 INFO : Initialising browser for dromaeo_css test... 16:21:28 INFO - 2015-12-16 16:21:28,374 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0RY4x/profile http://localhost:59243/getInfo.html 16:21:32 INFO - 2015-12-16 16:21:32,610 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:21:32 INFO - 2015-12-16 16:21:32,610 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:21:32 INFO - 2015-12-16 16:21:32,610 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:21:32 INFO - 2015-12-16 16:21:32,610 DEBUG : BROWSER_OUTPUT: __metrics 16:21:32 INFO - 2015-12-16 16:21:32,694 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:21:32 INFO - 2015-12-16 16:21:32,762 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:21:33 INFO - 2015-12-16 16:21:33,994 INFO : Browser initialized. 16:21:33 INFO - 2015-12-16 16:21:33,995 INFO : Running cycle 1/1 for dromaeo_css test... 16:21:33 INFO - 2015-12-16 16:21:33,995 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpU0RY4x/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:21:45 INFO - 2015-12-16 16:21:45,975 DEBUG : BROWSER_OUTPUT: RSS: Main: 142475264 16:21:45 INFO - 2015-12-16 16:21:45,975 DEBUG : BROWSER_OUTPUT: 16:22:37 INFO - 2015-12-16 16:22:37,332 DEBUG : BROWSER_OUTPUT: 1450311757330 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:24:49 INFO - 2015-12-16 16:24:49,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59243/tests/dromaeo/cssquery-ext.html) 16:24:50 INFO - 2015-12-16 16:24:50,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 230416384 16:24:50 INFO - 2015-12-16 16:24:50,435 DEBUG : BROWSER_OUTPUT: 16:27:52 INFO - 2015-12-16 16:27:52,839 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-ext.html (next: http://localhost:59243/tests/dromaeo/cssquery-jquery.html) 16:27:53 INFO - 2015-12-16 16:27:53,420 DEBUG : BROWSER_OUTPUT: RSS: Main: 221335552 16:27:53 INFO - 2015-12-16 16:27:53,420 DEBUG : BROWSER_OUTPUT: 16:30:55 INFO - 2015-12-16 16:30:55,463 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59243/tests/dromaeo/cssquery-mootools.html) 16:30:56 INFO - 2015-12-16 16:30:56,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 218382336 16:30:56 INFO - 2015-12-16 16:30:56,044 DEBUG : BROWSER_OUTPUT: 16:33:58 INFO - 2015-12-16 16:33:58,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59243/tests/dromaeo/cssquery-prototype.html) 16:33:58 INFO - 2015-12-16 16:33:58,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 199790592 16:33:58 INFO - 2015-12-16 16:33:58,605 DEBUG : BROWSER_OUTPUT: 16:37:01 INFO - 2015-12-16 16:37:01,335 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59243/tests/dromaeo/cssquery-yui.html) 16:37:01 INFO - 2015-12-16 16:37:01,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 181522432 16:37:01 INFO - 2015-12-16 16:37:01,916 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,403 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/dromaeo/cssquery-yui.html (next: http://localhost:59243/tests/dromaeo/cssquery-dojo.html) 16:40:04 INFO - 2015-12-16 16:40:04,661 DEBUG : BROWSER_OUTPUT: RSS: Main: 255565824 16:40:04 INFO - 2015-12-16 16:40:04,661 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2631.6315715799788;2748.7251274872515;2756.462489814487;2760;2762;4610.308453731942;4781.019890922361;4786.808527658894;4789.928151077732;4803.495632958541;4668.62650987921;4725.952740472594;4740.952590474094;4826.589739872115;4852.078105160017;4252.659787217015;4314.568543145691;4332.545082766312;4405.801738921757;4500.729956202622;4480.52954439784;4509.909801803962;4525.321201819737;4537.818487260505;4547.7953492092765;4218.430511880888;4298.763568003758;4313.719608225455;4407.669424793154;4443.15580039793;4393.714408563433;4399.340098985178;4400.691951563392;4405.163019026375;4437.889052773707;4360.869173924787;4378.321360189176;4385.495667998157;4388.561143885618;4403.8458653946955;4488.551144885518;4569.794359253841;4591.311303304497;4617.191991401492;4737.170995075882;5099.643024988252;5107.693538387709;5113.284140220372;5119.308893299394;5146.536811686966;5108.463611320833;5121.51345622169;5123.231515272739;5127.1796512558185;5174.91326821368;4584.083183363341;4692.389989301369;4733.952660473386;4738.455077666113;4747.264174053027;5100.515451032146;5197.896042079213;5243.082460569385;5250.081235783799;5290.92063619046;5009.073321435546;5009.699418034929;5014.648974571745;5015.548600625962;5024.748762561931;4930.852074437773;5053.7220452875445;5097.745112744348;5099.133147364957;5148.897022059537;4967.875803104951;4981.9252711209365;4988.650794444354;5061.924071138936;5086.338775959101;5004.149294619923;5036.521530454601;5039.949600503948;5045.41977672565;5051.823186188466;4208.095259519157;4251.043515209053;4253.425787518708;4281.828726850891;4282.764447955392;3596.9280614387567;3632.219072899339;3699.8335074921692;3716.163863130828;3729.5151630287887;4398.824047038082;4402;4403.471583409947;4405.823767049346;4441.666874984389;5119.078565858107;5128.461511541234;5130.410002849645;5135.15269980449;5186.196139598368;4178.080822219107;4285.207236661166;4285.678574106954;4289.914201715948;4392.802323895432;4526.388937493396;4531.77341132942;4546.340780586796;4549.977250113794;4568.200564901129;4824.131656301899;4882.389701287339;4884.316195732529;4891.364122664031;4894.583960363409;4858.708477491362;4977.651564390458;4979.477154898684;4982.252662100714;5067.569256613229;4745.928811067905;4885.682430641997;4891.266310053378;4905.337779399735;4951.5048495150195;5063.974680126576;5075;5075.111855425212;5079.949200507947;5122.949795292031;4901.117798796251;5020.221865610836;5141.177411614124;5145.974270128625;5149;4775.785089670903;4804.903901922012;4819.036192761532;4825.662203645711;4885.462599114024;4860.270959356125;4866;4870.8538743836325;4890.657653964188;4911.901761964669;4658.627309815274;4756.7145971241835;4785.665003449864;4798.256270278112;4820.228763397839;4868.780904859361;4903.730294833818;4928.581070609039;4956.454789973028;4996.475370086088;4843.515648435128;4892.8532144035735;4894.388201474816;4905.068037072945;4938.950610493993 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: |1;ext.html;557.2811073714907;563.0653115827724;566.4873289672846;573.4580821124036;582.065784416012;27045.72954270457;27593.862030689845;35649.2870142597;36472;36494.27011459769;40834.38748418769;41434;41437;41491;41513.58486415135;7086.511832515178;7973.720919767809;8155.836883262331;8160.673573057071;8165.918340816575;7242;7353.264673532631;9737.51312434379;9936.652217172401;9988.550515226832;10203.132733717643;10306.536205870716;10312.845307320396;10315.587376504931;10327.27709060366;7167.534110282815;7315.195328513859;10189.388636681786;10294;10296.588136474495;10290.125339346165;10598.523066462029;10599.152067834555;10600.098991585724;10608.681739547827;37310.25379492395;37568.24863502714;37746.62253377486;37792.62207377919;37838.621613783784;2938.3388737534096;2962.2742428105253;2989.2825721826607;3346.7991920484847;3479.8434070466888;28676.426471470662;28708;28929.42141157186;29103.272418189503;29745.25636859074;3286.96713032869;3335.5663763710804;3382.6092569879256;3383.2387712764676;3395.337909107725;218288;218630;218652;218864;219070;53122;56984;57501.71249143811;57582;57585;46867;61415.692921535105;62310.68844655748;62767.686161569814;62773.37226627766;14435.278236088154;14674.633134171518;14689.265536723122;14693.412263509339;14700.264986750619;10522;10622.787544249071;10659.84010239847;10660.520276587573;10665.093467055232;18825.152868120967;18896.71654925177;19062.80937190638;19076.61846763057;19901.900490497454;7452.254774522613;7736.303732664087;7738.458307918504;7816.8827467588035;7885.093214280317;850.7235148576614;853.3375867293959;898.4519443139679;996.267743208741;1031.4945676618404;26527.336816579354;26919.865400672872;27023.324416889736;27141.1857644271;27201.72798271992;954.4845783277092;993.3940296419179;1006.4011912911806;1103.5144536403957;1149.431031639344;14285.928570357082;14362.712745745235;14410.85589144116;14459.78310325346;14570.85429145695;258588;262735;262910;263010;264075;47129.5287047132;47558.762206188745;47586.28620570694;47606.761966189944;47623;1243.521244320943;1249.119370843553;1251.5431867368527;1264.7723409786327;1378.9933348655538;22340.21809236669;25480.617790733526;25948.48103037891;25983.220503384928;29798;40828.79585602053;41168;41386.58613413827;41510.377344340464;41534.58465415307;197712;199396;199598;200213;200328;24089.156879509133;28197.859010704815;29362;29563;29651.851740742022;33677.32645347128;34172.65827341794;34408;34865;34978;29550.261243469085;29750.702492974793;32766.50850237296;33775.3244935095;34382.14044648904;32625.551056680335;33161.83419082889;33385.499217512246;33400.16499587432;33686.66313336933;32857.835710821295;32948.341033179684;33063.17342066467;33289.334213316084;33418.66581334253;28556;29269.26826829261;30159.547606786353;30512.694873050987;30561.694383055885;23552.6467102997;23985.640215396434;24075.277741667778;24151.637725433782;24307.27078187657 16:40:04 INFO - 2015-12-16 16:40:04,662 DEBUG : BROWSER_OUTPUT: |2;jquery.html;327.11841586923254;327.19510005386735;328.0764647517239;332.06523635964766;332.58593051650695;12175.756484870297;12548.937255313711;15026;15547.22263886804;15567.29947152378;13114.213147211174;14227.790637795773;15843.12862792546;16598.917005414954;16631.584210394747;5083.7712302946275;5089.491050894918;5090.389153301609;5118.669146022043;5148.871278218037;3852.0947577319307;3943.940840887389;5112.386513618371;5155.948440515603;5814.331351894544;5934.495567876714;5951.285845698522;5972.79095231667;5977.910331345033;5978.790742324019;5855.79504717335;6018.759249630009;6053;6064.302605200414;6069.757209711606;5303.257543943851;5315.681059136464;5329.520343169094;5331.147016477384;5338.759755810997;19467.513312167168;19682.90158549198;19879.30422435222;20402;20417.97910104489;1929.9324523641606;1964.72493850861;2147.8281737460966;2318.6058370077126;2587.133310341038;13055.543055992996;13147.802782958168;13150.276734779583;13459.394327255297;13605.727885442335;1731.852792512638;1748.7027205375116;1762.4448298785842;1797.3888877781487;1859.7768267807949;52893;55563.72218138924;55573.16640250399;55664.443355566335;56375.15437268444;9578.712638620853;9643.855342169873;9778.07108324708;9815.460149691835;9841.261905357127;12507.312097834525;12509.812352814715;12518.81221781674;12534.310612916195;12557.93721031389;7342.622493322119;7370.152432470228;7408.664234705861;7446.73936412223;7492.887606685904;7069.9646501767165;7085.50401471892;7088.751893683696;7089.53917995339;7111.857762844714;5721.542276617861;5806.738696758656;5918.615290006222;5961.539422841432;5986.9401305986385;1584.5563242292176;1652.7190377635832;1657.2128239086337;1681.2014293210627;1687.5190570687296;373.76452834713956;796.6892911764417;837.3552364679163;884.4648987362682;934.7102398256562;9258.90741092594;9292.581833817494;9557.996410376949;9584.76038099053;9744.610215591298;378.8049154685339;408.65672834818895;410.65504975820454;417.6387424877459;419.97690127042694;5080.949190508121;5190.480951904779;5198.870028249324;5240.947590524046;5317;468166;472706;474650;485022;492354;66412.66793666001;66696;67298;72477;72905.63547182336;434.2639226511097;442.24376316498507;447.29550957242475;450.223364695897;452.2041207474868;9551.808963820824;13970.650733731738;13987.790183147465;14576.416943322149;14579.92710036443;31525.684743152276;32096.67903320937;32214.838925806158;32414.189645259055;34650;41827.58172418237;41971.58028419677;42852.78573607112;43037.3544396828;43056.35415468708;9175.77060573491;9203.447793132433;9390.342676012613;9394.859077113711;9409.200217981548;10852.511636976196;13798.517051903134;16778.832211678215;17008.14959252057;17222.655546889244;14172.645683857574;14198.645033874236;14421.134731916118;14625.122492650475;14654.78017829712;13776.188145024822;13871.930640346734;14020.929895350459;14213.076150050214;14482.493112741004;10332.431716255678;14403.711925761636;14420.711585768435;14755.114693118447;14885.255737213312;9051.59267832936;9148.176664100263;9211.447313161232;9445.574949127444;9451.669191578261;13911;14062.929685351508;14203.360848761624;14476;14608.415663373346 16:40:04 INFO - 2015-12-16 16:40:04,663 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1232.4515590562203;1414.6039109049464;1425.7077299153668;1631.7144499712547;1703.7444383342502;6246.094316324136;7084.574925504473;7204.60374679393;7246.492745507817;7267.636618169096;7020.403265722407;7166.283371662831;7176.748813791505;7181.425485961124;7200.063991681074;1734.670412621604;1760.5070580237555;2051.1385218208316;2090.205721825704;2130.52063285761;2076.169532187122;2080.365488525999;2081.4172031831113;2086.113401804227;2087.1651339464183;2030.6649402848511;2065.7624373197123;2118.8622739521957;2119.607872543577;2121.501447159916;2083.7916208379193;2094.3088780702333;2117.925872594452;2118.9576208475823;2142.218090396994;2106.3996760923064;2126.223928266187;2152.5049238675037;2154.849160558746;2154.9030293636665;7014.4739144563855;7125.25184855593;7125.643717814089;7132.037174981363;7134.500584959055;4178.582141785828;4249.46881639795;4254.340577210537;4273.636740877029;4274.551172126944;2663.0546156114688;2704.161709869927;2724.5913113033007;2736.808423410362;2765.046059109604;840.3193413335157;841.2260720137489;846.9153084691543;865.446114486729;867.4361664917791;9618.615255389775;9620.807583848355;9622;9624.615015399446;9634.229261659051;3873.535175778868;3882.8446862125766;3926.1166237596312;3939.940900886489;3944.1717239379477;8240.958795205986;8261.793455163668;8268.09051004389;8269.875951860728;8295.585220738938;4250.872473825791;4251.681123915719;4252.936205956913;4256.297710877732;4263.701540892108;3802.3535998880257;3820.1977584707524;3832.2335532893535;3861.1505468796818;3867.806609669505;2954.6749857515656;2959.4377068356944;3066.340736741611;3438.535797667333;3478.4956181353564;1103.9834402483968;1140.2702270546856;1142.8114361130486;1143.2511704833348;1147.3632134165618;964.4936408385654;1042.4579218806177;1170.7073231692077;1212.89083982442;1213.77545154145;6768.255491895888;6822.897656535156;6839.247682754893;6843.418309443753;6848;1028.6091285311534;1043.212374657129;1050.1703654113317;1060.2737125069352;1075.7794652096302;5318.494742999486;5424.945750542444;5428;5431.293931788921;5437.45625437461;8428.747137585882;8567.957160214284;8804.47173169612;8903.866442003375;8911.420757650732;8702.608382622671;8751.693690720795;8773.298136149093;8781.560921953876;8805.559722014003;6687.565308254948;6783.728650854009;6849.760258391032;6858.759943401957;6860.485463590251;6599.868002640016;6635.0710900473005;6655.767048153291;6667.666616669244;6673.432758215412;7646.235376462309;7776.961115194614;7845.097813751491;7904.407169462198;7921.366290696616;7889.960550197442;8011.158828323175;8094.352451803724;8101.513909165469;8206;6329.303776584664;6347.841303967438;6394.58435201729;6395.040743888454;6396.42432181106;5627.493525582717;5973.313068997121;6520.217573891164;6756.763513277012;6840.692168852314;6342.112104305309;6511.316311787384;6563.310852360433;6639.734410623521;6674.733010679518;6295.370462953668;6319.778807741707;6349.301576826638;6424.93575064262;6538.1500404947055;6485.0596663484475;6516.185476815398;6523.086767852599;6530.314316996647;6547.214334279917;6096.268447786294;6123.632582045091;6129.662868542273;6130.540209484396;6137.3248942617165;5865.618734782225;6070.816190842744;6079.209702738793;6147.907781383194;6182.412670796267 16:40:04 INFO - 2015-12-16 16:40:04,665 DEBUG : BROWSER_OUTPUT: |4;prototype.html;302.8289016705561;303.44469620594316;308.837860123435;311.1893517387206;312.03892012601176;5234.371875374955;5312;5452.073147564914;5463.726813659316;5470.370907345657;5268.604854635908;5302.151655735083;5337.039332920082;5337.946620533793;5345.01117293301;3885.873096801938;3980.6616437602693;4114.650254728344;4114.958850411503;4115.382692596105;3954.5649978502342;4053.250148722496;4072.8370865165507;4073.2260870434525;4087.3664581989838;4016.959830401702;4018.557958624549;4025.8188381522755;4028.939565906514;4035.273650742865;3849.788261645608;3919.960800391988;3935.5670876203594;4026.3557830747086;4036.8183431745642;3502.176988407722;3509.859605615798;3512.262424890776;3514.578250609943;3517.525134106914;5064.215046667772;5066.949330506684;5075.568576670988;5086.084504789136;5090.847274581732;4569.748663823489;4605.930911036304;4607.585317321457;4611.654125940568;4621.468531118897;5369.677819330853;5508.669479831223;5516.668999860021;5521.696306703129;5526.917096243559;3814.4278358246206;3834.3673293906472;3837.8656747014;3840.2895464339185;3843.6540711335833;5757.309122905236;5841.386654401269;5841.503472204868;5844.561657875676;5847.619904706181;3966.147278335172;3971.72197946141;3973.8013099344917;3976.4830572025453;3977.54258260298;3899.3566061599518;4028.254772867029;4037.6971727120585;4039.656629186552;4040.070783719761;4568.109218702388;4606.907861842745;4607.562281583244;4613.95386046142;4615.746133962597;5548.056830338852;5548.334199896039;5552.41699621542;5554.833354999357;5562.137868630369;1415.497498388078;1435.181946290625;1435.2751860310477;1435.4186554445466;1436.1311406599066;943.8018016216535;946.6118891254553;963.0706368354571;966.7631430299481;969.937917979811;4899.681520701143;4905.141600219948;4908.337374454403;4914.311996320518;4915.508449155127;5760.107183386582;5767.798127065533;5780.393058728773;5782.10377391505;5785.826425207167;4890;4906.607471402351;4906.779194936165;4912.852614421573;4915.238138088602;3034.969650303469;3083.2137804859617;3113.6263648361887;3116.283254851397;3118.3607360491496;5508.283923089973;5512.448755124456;5513.062779327524;5524.309461317335;5531.917021244684;5952.077427998667;5962.791302304398;5964.552658550626;5982.1325907744;5989.460948514655;5520.420355862657;5532.948739739437;5534.4742249486235;5541.750621222055;5544.667319960815;5669.858253543694;5776.595638305278;5826.504747096375;5833.183354330312;5837.883242335214;5682.204491371129;5683.147527870852;5683.687397193194;5691.288588926384;5692.430756924275;5525.696086715108;5529.529989950899;5530.5022547970875;5531.308586426697;5533.529649979636;3903.4535165076345;3965.2466031453932;3966.5835087315418;3984.6613037892103;4004.439378487072;5811.099279611667;5819.70901454934;5821.446962538552;5822.534197264124;5824.15549745293;5566.944330556643;5574.9163762542785;5575.219469274386;5577.358603760619;5582.162675598693;5571.08077167279;5581.916271255853;5595.104783234663;5595.300587426572;5604.383517812956;5329.280547126088;5424.2406063151975;5470.699111548903;5476.2607048048;5478.589105817;5308.336457942757;5484.095124304445;5564.721763911869;5574.609777315712;5614.24207731951;5349.866253343697;5463.180522921593;5489.945100549103;5502.202180683698;5504.091824849015 16:40:04 INFO - 2015-12-16 16:40:04,668 DEBUG : BROWSER_OUTPUT: |5;yui.html;653.8986457099148;699.405505320478;709.5139829216987;723.0203074833598;748.648135376373;11989.160758746892;12348.81476777848;12350.073744469157;12396.38018099096;12548.937255313711;13549.458021679146;13632;13651.795223071662;13659.863401365983;13672.453101875913;645.5190882792326;651.609034579251;655.2235600813028;822.1696086952162;834.1075049696827;813.3899575318511;816.3917881178501;819.573821612761;824.1470078468786;826.0830478169228;812.8618134917049;861.444368382393;872.7905302727363;874.903760586335;874.9387542872001;666.2870728320698;677.7966610016999;849.7195925344621;865.5715420866649;866.969656062038;640.4204195203348;640.679660169915;640.9230892292954;641.0064400179702;641.2785616181795;12061.155719099579;12198.329091899943;12227.266364018187;12230.082743794163;12237.877621223763;10673.1995100367;11061.944690276578;11142.777144457066;11151.330920144736;11188.608398706006;9076.593974686506;9314.90685093154;9476.620935162586;9487.525623718855;9580.856287155699;3190.5692731481417;3227.160938156073;3234.4986527088104;3277.8197199154038;3287.589051368579;40423.7978810104;40476;40707.38938915889;40721.28098863684;40738.59261407348;8864.157904999014;8901.777455563662;8971.192592666692;9084.772880678036;9131.543422828832;15594.9220253898;15605.141717205663;15605.453809116854;15606.9219653901;15614.141222232885;6130.264368275835;6137.447629713347;6286.245650521875;6335.968320158462;6620.271770105284;3312.38720836646;3343.8996830095134;3417.974607617705;3505.964940350615;3532.876349327761;2537.2895589235045;2594.8971687032936;2595.5976823592373;2596.0135148643394;2601.1806281021795;429.225248426593;432.09907343189803;437.7482947305312;444.97330160189847;445.0209539014182;560.7280468972546;576.9192313076172;581.8831765260712;596.9522438204933;618.6628287583278;7774.533527988338;7901.170377110436;8070.878936815952;8077.7576672699915;8175.305099066527;600.3816069448475;600.7566935391174;606.3633185155569;608.5739982012609;617.7528988404584;3688.5758137814496;4007.6192761687594;4063.146739184804;4066.0038290618986;4202.957970420318;49668.75165624149;51735;52042;52075;52096.47903520992;40120;40135.79932100379;40155.39766903499;40279.798601007395;40738.79630601828;42303.73500354653;43221.567784321756;43446.348304775456;43820.78089609532;44077.55922440799;8191.385646076687;8409.95795021021;8442;8553.74338769838;8609.526476043879;31571.842140789147;32169.195770105936;32433.51349729803;32515.187120321236;32597.674023259464;36014.639853601126;37037;38763.41854872236;40419.39370909498;40488.59511404848;10806.567737290421;10836;11048.116150707763;11080.445977701243;11113.833292500458;12002.39988000614;12174.330411827434;12322.32227227511;12786.104972652198;12835.743285134431;10526.210534210119;11435.428228588704;11517.884821151682;11527.250728702607;11890.46492907804;10990.890091098987;11100.389478578756;11617.825732614187;11670.241434306743;12037.939810300892;11119.722006949567;11244.887551124712;11336.319820810448;11523.884761152616;11752.941235293769;9169.862452063091;9825.606975720892;10174.949125254327;10237.590496380062;10357.882990594684;8968.506732129796;9586.66446674363;9782.706518804447;9790.411709065791;9793.331250279172 16:40:04 INFO - 2015-12-16 16:40:04,668 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:40:04 INFO - 2015-12-16 16:40:04,668 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,873 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: __startTimestamp1450312804655__endTimestamp 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:40:04 INFO - 2015-12-16 16:40:04,669 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:40:04 INFO - 2015-12-16 16:40:04,670 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,670 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4686.02 Median:4824.13 stddev:487.48 (10.1%) stddev-sans-first:461.56 16:40:04 INFO - 2015-12-16 16:40:04,670 DEBUG : BROWSER_OUTPUT: Values: 2631.6 2748.7 2756.5 2760.0 2762.0 4610.3 4781.0 4786.8 4789.9 4803.5 4668.6 4726.0 4741.0 4826.6 4852.1 4252.7 4314.6 4332.5 4405.8 4500.7 4480.5 4509.9 4525.3 4537.8 4547.8 4218.4 4298.8 4313.7 4407.7 4443.2 4393.7 4399.3 4400.7 4405.2 4437.9 4360.9 4378.3 4385.5 4388.6 4403.8 4488.6 4569.8 4591.3 4617.2 4737.2 5099.6 5107.7 5113.3 5119.3 5146.5 5108.5 5121.5 5123.2 5127.2 5174.9 4584.1 4692.4 4734.0 4738.5 4747.3 5100.5 5197.9 5243.1 5250.1 5290.9 5009.1 5009.7 5014.6 5015.5 5024.7 4930.9 5053.7 5097.7 5099.1 5148.9 4967.9 4981.9 4988.7 5061.9 5086.3 5004.1 5036.5 5039.9 5045.4 5051.8 4208.1 4251.0 4253.4 4281.8 4282.8 3596.9 3632.2 3699.8 3716.2 3729.5 4398.8 4402.0 4403.5 4405.8 4441.7 5119.1 5128.5 5130.4 5135.2 5186.2 4178.1 4285.2 4285.7 4289.9 4392.8 4526.4 4531.8 4546.3 4550.0 4568.2 4824.1 4882.4 4884.3 4891.4 4894.6 4858.7 4977.7 4979.5 4982.3 5067.6 4745.9 4885.7 4891.3 4905.3 4951.5 5064.0 5075.0 5075.1 5079.9 5122.9 4901.1 5020.2 5141.2 5146.0 5149.0 4775.8 4804.9 4819.0 4825.7 4885.5 4860.3 4866.0 4870.9 4890.7 4911.9 4658.6 4756.7 4785.7 4798.3 4820.2 4868.8 4903.7 4928.6 4956.5 4996.5 4843.5 4892.9 4894.4 4905.1 4939.0 16:40:04 INFO - 2015-12-16 16:40:04,670 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,670 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39357.87 Median:16574.42 stddev:59305.23 (357.8%) stddev-sans-first:59400.04 16:40:04 INFO - 2015-12-16 16:40:04,672 DEBUG : BROWSER_OUTPUT: Values: 557.3 563.1 566.5 573.5 582.1 27045.7 27593.9 35649.3 36472.0 36494.3 40834.4 41434.0 41437.0 41491.0 41513.6 7086.5 7973.7 8155.8 8160.7 8165.9 7242.0 7353.3 9737.5 9936.7 9988.6 10203.1 10306.5 10312.8 10315.6 10327.3 7167.5 7315.2 10189.4 10294.0 10296.6 10290.1 10598.5 10599.2 10600.1 10608.7 37310.3 37568.2 37746.6 37792.6 37838.6 2938.3 2962.3 2989.3 3346.8 3479.8 28676.4 28708.0 28929.4 29103.3 29745.3 3287.0 3335.6 3382.6 3383.2 3395.3 218288.0 218630.0 218652.0 218864.0 219070.0 53122.0 56984.0 57501.7 57582.0 57585.0 46867.0 61415.7 62310.7 62767.7 62773.4 14435.3 14674.6 14689.3 14693.4 14700.3 10522.0 10622.8 10659.8 10660.5 10665.1 18825.2 18896.7 19062.8 19076.6 19901.9 7452.3 7736.3 7738.5 7816.9 7885.1 850.7 853.3 898.5 996.3 1031.5 26527.3 26919.9 27023.3 27141.2 27201.7 954.5 993.4 1006.4 1103.5 1149.4 14285.9 14362.7 14410.9 14459.8 14570.9 258588.0 262735.0 262910.0 263010.0 264075.0 47129.5 47558.8 47586.3 47606.8 47623.0 1243.5 1249.1 1251.5 1264.8 1379.0 22340.2 25480.6 25948.5 25983.2 29798.0 40828.8 41168.0 41386.6 41510.4 41534.6 197712.0 199396.0 199598.0 200213.0 200328.0 24089.2 28197.9 29362.0 29563.0 29651.9 33677.3 34172.7 34408.0 34865.0 34978.0 29550.3 29750.7 32766.5 33775.3 34382.1 32625.6 33161.8 33385.5 33400.2 33686.7 32857.8 32948.3 33063.2 33289.3 33418.7 28556.0 29269.3 30159.5 30512.7 30561.7 23552.6 23985.6 24075.3 24151.6 24307.3 16:40:04 INFO - 2015-12-16 16:40:04,672 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,672 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26011.48 Median:43046.85 stddev:78132.53 (181.5%) stddev-sans-first:78327.91 16:40:04 INFO - 2015-12-16 16:40:04,673 DEBUG : BROWSER_OUTPUT: Values: 327.1 327.2 328.1 332.1 332.6 12175.8 12548.9 15026.0 15547.2 15567.3 13114.2 14227.8 15843.1 16598.9 16631.6 5083.8 5089.5 5090.4 5118.7 5148.9 3852.1 3943.9 5112.4 5155.9 5814.3 5934.5 5951.3 5972.8 5977.9 5978.8 5855.8 6018.8 6053.0 6064.3 6069.8 5303.3 5315.7 5329.5 5331.1 5338.8 19467.5 19682.9 19879.3 20402.0 20418.0 1929.9 1964.7 2147.8 2318.6 2587.1 13055.5 13147.8 13150.3 13459.4 13605.7 1731.9 1748.7 1762.4 1797.4 1859.8 52893.0 55563.7 55573.2 55664.4 56375.2 9578.7 9643.9 9778.1 9815.5 9841.3 12507.3 12509.8 12518.8 12534.3 12557.9 7342.6 7370.2 7408.7 7446.7 7492.9 7070.0 7085.5 7088.8 7089.5 7111.9 5721.5 5806.7 5918.6 5961.5 5986.9 1584.6 1652.7 1657.2 1681.2 1687.5 373.8 796.7 837.4 884.5 934.7 9258.9 9292.6 9558.0 9584.8 9744.6 378.8 408.7 410.7 417.6 420.0 5080.9 5190.5 5198.9 5240.9 5317.0 468166.0 472706.0 474650.0 485022.0 492354.0 66412.7 66696.0 67298.0 72477.0 72905.6 434.3 442.2 447.3 450.2 452.2 9551.8 13970.7 13987.8 14576.4 14579.9 31525.7 32096.7 32214.8 32414.2 34650.0 41827.6 41971.6 42852.8 43037.4 43056.4 9175.8 9203.4 9390.3 9394.9 9409.2 10852.5 13798.5 16778.8 17008.1 17222.7 14172.6 14198.6 14421.1 14625.1 14654.8 13776.2 13871.9 14020.9 14213.1 14482.5 10332.4 14403.7 14420.7 14755.1 14885.3 9051.6 9148.2 9211.4 9445.6 9451.7 13911.0 14062.9 14203.4 14476.0 14608.4 16:40:04 INFO - 2015-12-16 16:40:04,673 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,673 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5020.53 Median:6214.25 stddev:2607.38 (42.0%) stddev-sans-first:2599.15 16:40:04 INFO - 2015-12-16 16:40:04,673 DEBUG : BROWSER_OUTPUT: Values: 1232.5 1414.6 1425.7 1631.7 1703.7 6246.1 7084.6 7204.6 7246.5 7267.6 7020.4 7166.3 7176.7 7181.4 7200.1 1734.7 1760.5 2051.1 2090.2 2130.5 2076.2 2080.4 2081.4 2086.1 2087.2 2030.7 2065.8 2118.9 2119.6 2121.5 2083.8 2094.3 2117.9 2119.0 2142.2 2106.4 2126.2 2152.5 2154.8 2154.9 7014.5 7125.3 7125.6 7132.0 7134.5 4178.6 4249.5 4254.3 4273.6 4274.6 2663.1 2704.2 2724.6 2736.8 2765.0 840.3 841.2 846.9 865.4 867.4 9618.6 9620.8 9622.0 9624.6 9634.2 3873.5 3882.8 3926.1 3939.9 3944.2 8241.0 8261.8 8268.1 8269.9 8295.6 4250.9 4251.7 4252.9 4256.3 4263.7 3802.4 3820.2 3832.2 3861.2 3867.8 2954.7 2959.4 3066.3 3438.5 3478.5 1104.0 1140.3 1142.8 1143.3 1147.4 964.5 1042.5 1170.7 1212.9 1213.8 6768.3 6822.9 6839.2 6843.4 6848.0 1028.6 1043.2 1050.2 1060.3 1075.8 5318.5 5424.9 5428.0 5431.3 5437.5 8428.7 8568.0 8804.5 8903.9 8911.4 8702.6 8751.7 8773.3 8781.6 8805.6 6687.6 6783.7 6849.8 6858.8 6860.5 6599.9 6635.1 6655.8 6667.7 6673.4 7646.2 7777.0 7845.1 7904.4 7921.4 7890.0 8011.2 8094.4 8101.5 8206.0 6329.3 6347.8 6394.6 6395.0 6396.4 5627.5 5973.3 6520.2 6756.8 6840.7 6342.1 6511.3 6563.3 6639.7 6674.7 6295.4 6319.8 6349.3 6424.9 6538.2 6485.1 6516.2 6523.1 6530.3 6547.2 6096.3 6123.6 6129.7 6130.5 6137.3 5865.6 6070.8 6079.2 6147.9 6182.4 16:40:04 INFO - 2015-12-16 16:40:04,674 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,674 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4611.61 Median:5333.16 stddev:1370.15 (25.7%) stddev-sans-first:1335.29 16:40:04 INFO - 2015-12-16 16:40:04,674 DEBUG : BROWSER_OUTPUT: Values: 302.8 303.4 308.8 311.2 312.0 5234.4 5312.0 5452.1 5463.7 5470.4 5268.6 5302.2 5337.0 5337.9 5345.0 3885.9 3980.7 4114.7 4115.0 4115.4 3954.6 4053.3 4072.8 4073.2 4087.4 4017.0 4018.6 4025.8 4028.9 4035.3 3849.8 3920.0 3935.6 4026.4 4036.8 3502.2 3509.9 3512.3 3514.6 3517.5 5064.2 5066.9 5075.6 5086.1 5090.8 4569.7 4605.9 4607.6 4611.7 4621.5 5369.7 5508.7 5516.7 5521.7 5526.9 3814.4 3834.4 3837.9 3840.3 3843.7 5757.3 5841.4 5841.5 5844.6 5847.6 3966.1 3971.7 3973.8 3976.5 3977.5 3899.4 4028.3 4037.7 4039.7 4040.1 4568.1 4606.9 4607.6 4614.0 4615.7 5548.1 5548.3 5552.4 5554.8 5562.1 1415.5 1435.2 1435.3 1435.4 1436.1 943.8 946.6 963.1 966.8 969.9 4899.7 4905.1 4908.3 4914.3 4915.5 5760.1 5767.8 5780.4 5782.1 5785.8 4890.0 4906.6 4906.8 4912.9 4915.2 3035.0 3083.2 3113.6 3116.3 3118.4 5508.3 5512.4 5513.1 5524.3 5531.9 5952.1 5962.8 5964.6 5982.1 5989.5 5520.4 5532.9 5534.5 5541.8 5544.7 5669.9 5776.6 5826.5 5833.2 5837.9 5682.2 5683.1 5683.7 5691.3 5692.4 5525.7 5529.5 5530.5 5531.3 5533.5 3903.5 3965.2 3966.6 3984.7 4004.4 5811.1 5819.7 5821.4 5822.5 5824.2 5566.9 5574.9 5575.2 5577.4 5582.2 5571.1 5581.9 5595.1 5595.3 5604.4 5329.3 5424.2 5470.7 5476.3 5478.6 5308.3 5484.1 5564.7 5574.6 5614.2 5349.9 5463.2 5489.9 5502.2 5504.1 16:40:04 INFO - 2015-12-16 16:40:04,674 DEBUG : BROWSER_OUTPUT: 16:40:04 INFO - 2015-12-16 16:40:04,674 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12476.09 Median:40738.69 stddev:13821.49 (33.9%) stddev-sans-first:13831.74 16:40:04 INFO - 2015-12-16 16:40:04,675 DEBUG : BROWSER_OUTPUT: Values: 653.9 699.4 709.5 723.0 748.6 11989.2 12348.8 12350.1 12396.4 12548.9 13549.5 13632.0 13651.8 13659.9 13672.5 645.5 651.6 655.2 822.2 834.1 813.4 816.4 819.6 824.1 826.1 812.9 861.4 872.8 874.9 874.9 666.3 677.8 849.7 865.6 867.0 640.4 640.7 640.9 641.0 641.3 12061.2 12198.3 12227.3 12230.1 12237.9 10673.2 11061.9 11142.8 11151.3 11188.6 9076.6 9314.9 9476.6 9487.5 9580.9 3190.6 3227.2 3234.5 3277.8 3287.6 40423.8 40476.0 40707.4 40721.3 40738.6 8864.2 8901.8 8971.2 9084.8 9131.5 15594.9 15605.1 15605.5 15606.9 15614.1 6130.3 6137.4 6286.2 6336.0 6620.3 3312.4 3343.9 3418.0 3506.0 3532.9 2537.3 2594.9 2595.6 2596.0 2601.2 429.2 432.1 437.7 445.0 445.0 560.7 576.9 581.9 597.0 618.7 7774.5 7901.2 8070.9 8077.8 8175.3 600.4 600.8 606.4 608.6 617.8 3688.6 4007.6 4063.1 4066.0 4203.0 49668.8 51735.0 52042.0 52075.0 52096.5 40120.0 40135.8 40155.4 40279.8 40738.8 42303.7 43221.6 43446.3 43820.8 44077.6 8191.4 8410.0 8442.0 8553.7 8609.5 31571.8 32169.2 32433.5 32515.2 32597.7 36014.6 37037.0 38763.4 40419.4 40488.6 10806.6 10836.0 11048.1 11080.4 11113.8 12002.4 12174.3 12322.3 12786.1 12835.7 10526.2 11435.4 11517.9 11527.3 11890.5 10990.9 11100.4 11617.8 11670.2 12037.9 11119.7 11244.9 11336.3 11523.9 11752.9 9169.9 9825.6 10174.9 10237.6 10357.9 8968.5 9586.7 9782.7 9790.4 9793.3 16:40:04 INFO - 2015-12-16 16:40:04,675 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:40:04 INFO - 2015-12-16 16:40:04,675 DEBUG : BROWSER_OUTPUT: 16:40:05 INFO - 2015-12-16 16:40:05,440 INFO : Browser exited with error code: 0 16:40:05 INFO - 2015-12-16 16:40:05,461 INFO : Completed test dromaeo_css (00:18:37) 16:40:05 INFO - 2015-12-16 16:40:05,461 INFO : Starting test kraken 16:40:05 INFO - 2015-12-16 16:40:05,461 DEBUG : operating with platform_type : linux_ 16:40:05 INFO - 2015-12-16 16:40:05,461 INFO : Initialising browser for kraken test... 16:40:05 INFO - 2015-12-16 16:40:05,467 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVm_ge/profile http://localhost:59243/getInfo.html 16:40:09 INFO - 2015-12-16 16:40:09,624 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:40:09 INFO - 2015-12-16 16:40:09,624 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:40:09 INFO - 2015-12-16 16:40:09,624 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:40:09 INFO - 2015-12-16 16:40:09,624 DEBUG : BROWSER_OUTPUT: __metrics 16:40:09 INFO - 2015-12-16 16:40:09,726 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:40:09 INFO - 2015-12-16 16:40:09,808 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:40:10 INFO - 2015-12-16 16:40:10,886 INFO : Browser initialized. 16:40:10 INFO - 2015-12-16 16:40:10,887 INFO : Running cycle 1/1 for kraken test... 16:40:10 INFO - 2015-12-16 16:40:10,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpdVm_ge/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:40:22 INFO - 2015-12-16 16:40:22,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 142200832 16:40:22 INFO - 2015-12-16 16:40:22,904 DEBUG : BROWSER_OUTPUT: 16:40:25 INFO - 2015-12-16 16:40:25,560 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59243/tests/kraken/driver.html?testName=audio-beat-detection) 16:40:26 INFO - 2015-12-16 16:40:26,141 DEBUG : BROWSER_OUTPUT: RSS: Main: 178147328 16:40:26 INFO - 2015-12-16 16:40:26,142 DEBUG : BROWSER_OUTPUT: 16:40:28 INFO - 2015-12-16 16:40:28,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59243/tests/kraken/driver.html?testName=audio-dft) 16:40:29 INFO - 2015-12-16 16:40:29,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 166174720 16:40:29 INFO - 2015-12-16 16:40:29,520 DEBUG : BROWSER_OUTPUT: 16:40:32 INFO - 2015-12-16 16:40:32,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59243/tests/kraken/driver.html?testName=audio-fft) 16:40:33 INFO - 2015-12-16 16:40:33,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 153448448 16:40:33 INFO - 2015-12-16 16:40:33,065 DEBUG : BROWSER_OUTPUT: 16:40:35 INFO - 2015-12-16 16:40:35,138 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59243/tests/kraken/driver.html?testName=audio-oscillator) 16:40:35 INFO - 2015-12-16 16:40:35,712 DEBUG : BROWSER_OUTPUT: RSS: Main: 154791936 16:40:35 INFO - 2015-12-16 16:40:35,712 DEBUG : BROWSER_OUTPUT: 16:40:37 INFO - 2015-12-16 16:40:37,930 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:40:38 INFO - 2015-12-16 16:40:38,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 157777920 16:40:38 INFO - 2015-12-16 16:40:38,498 DEBUG : BROWSER_OUTPUT: 16:40:41 INFO - 2015-12-16 16:40:41,499 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59243/tests/kraken/driver.html?testName=imaging-darkroom) 16:40:42 INFO - 2015-12-16 16:40:42,069 DEBUG : BROWSER_OUTPUT: RSS: Main: 158732288 16:40:42 INFO - 2015-12-16 16:40:42,069 DEBUG : BROWSER_OUTPUT: 16:40:45 INFO - 2015-12-16 16:40:45,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59243/tests/kraken/driver.html?testName=imaging-desaturate) 16:40:46 INFO - 2015-12-16 16:40:46,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 159420416 16:40:46 INFO - 2015-12-16 16:40:46,118 DEBUG : BROWSER_OUTPUT: 16:40:48 INFO - 2015-12-16 16:40:48,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59243/tests/kraken/driver.html?testName=json-parse-financial) 16:40:49 INFO - 2015-12-16 16:40:49,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 159170560 16:40:49 INFO - 2015-12-16 16:40:49,553 DEBUG : BROWSER_OUTPUT: 16:40:51 INFO - 2015-12-16 16:40:51,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:40:51 INFO - 2015-12-16 16:40:51,897 DEBUG : BROWSER_OUTPUT: RSS: Main: 167231488 16:40:51 INFO - 2015-12-16 16:40:51,897 DEBUG : BROWSER_OUTPUT: 16:40:53 INFO - 2015-12-16 16:40:53,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:40:54 INFO - 2015-12-16 16:40:54,381 DEBUG : BROWSER_OUTPUT: RSS: Main: 165416960 16:40:54 INFO - 2015-12-16 16:40:54,381 DEBUG : BROWSER_OUTPUT: 16:40:56 INFO - 2015-12-16 16:40:56,519 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:40:57 INFO - 2015-12-16 16:40:57,100 DEBUG : BROWSER_OUTPUT: RSS: Main: 177631232 16:40:57 INFO - 2015-12-16 16:40:57,100 DEBUG : BROWSER_OUTPUT: 16:40:59 INFO - 2015-12-16 16:40:59,607 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:41:00 INFO - 2015-12-16 16:41:00,192 DEBUG : BROWSER_OUTPUT: RSS: Main: 182358016 16:41:00 INFO - 2015-12-16 16:41:00,193 DEBUG : BROWSER_OUTPUT: 16:41:02 INFO - 2015-12-16 16:41:02,773 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:41:03 INFO - 2015-12-16 16:41:03,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 180768768 16:41:03 INFO - 2015-12-16 16:41:03,346 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,115 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59243/tests/kraken/driver.html?testName=ai-astar) 16:41:05 INFO - 2015-12-16 16:41:05,373 DEBUG : BROWSER_OUTPUT: RSS: Main: 238706688 16:41:05 INFO - 2015-12-16 16:41:05,373 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;116;109;114;114;113;103;118;114;109 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;165;130;151;172;141;155;154;131;172;139 16:41:05 INFO - 2015-12-16 16:41:05,374 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;160;161;160;163;160;162;161;160;160 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;73;90;93;72;74;72;105;90;72 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;95;131;95;94;95;129;94;94;129 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;110;110;111;110;110 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;147;147;147;146;147;146;148 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;95;95;95;95;95;95;95 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;73;71;72;73;72;82;70;71 16:41:05 INFO - 2015-12-16 16:41:05,375 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;69;69;69;69;70;68;68;68 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;86;86;86;87;86;84;85;87;84 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;130;130;117;120;121;132;135;123;123 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;151;145;152;135;147;146;148;136 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;74;69;68;69;68;68;68;71 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:41:05 INFO - 2015-12-16 16:41:05,376 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,994 16:41:05 INFO - 2015-12-16 16:41:05,377 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:41:05 INFO - 2015-12-16 16:41:05,377 DEBUG : BROWSER_OUTPUT: __startTimestamp1450312865368__endTimestamp 16:41:05 INFO - 2015-12-16 16:41:05,377 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,377 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:05 INFO - 2015-12-16 16:41:05,378 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:112.30 Median:114.00 stddev:4.27 (3.7%) stddev-sans-first:4.52 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: Values: 113.0 116.0 109.0 114.0 114.0 113.0 103.0 118.0 114.0 109.0 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.00 Median:154.50 stddev:15.59 (10.1%) stddev-sans-first:15.69 16:41:05 INFO - 2015-12-16 16:41:05,379 DEBUG : BROWSER_OUTPUT: Values: 165.0 130.0 151.0 172.0 141.0 155.0 154.0 131.0 172.0 139.0 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.80 Median:161.00 stddev:1.03 (0.6%) stddev-sans-first:1.09 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: Values: 161.0 160.0 161.0 160.0 163.0 160.0 162.0 161.0 160.0 160.0 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:74.00 stddev:11.95 (16.1%) stddev-sans-first:12.36 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 90.0 93.0 72.0 74.0 72.0 105.0 90.0 72.0 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:94.50 stddev:16.97 (18.0%) stddev-sans-first:17.60 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 131.0 95.0 94.0 95.0 129.0 94.0 94.0 129.0 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.50 16:41:05 INFO - 2015-12-16 16:41:05,380 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 110.0 110.0 111.0 110.0 110.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.67 (0.5%) stddev-sans-first:0.67 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 147.0 147.0 147.0 146.0 147.0 146.0 148.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.90 Median:72.50 stddev:3.35 (4.6%) stddev-sans-first:3.55 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 73.0 71.0 72.0 73.0 72.0 82.0 70.0 71.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.85 (1.2%) stddev-sans-first:0.71 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 69.0 69.0 69.0 69.0 70.0 68.0 68.0 68.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:86.00 stddev:1.06 (1.2%) stddev-sans-first:1.12 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: Values: 86.0 86.0 86.0 86.0 87.0 86.0 84.0 85.0 87.0 84.0 16:41:05 INFO - 2015-12-16 16:41:05,381 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:126.50 stddev:6.03 (4.8%) stddev-sans-first:6.20 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: Values: 121.0 130.0 130.0 117.0 120.0 121.0 132.0 135.0 123.0 123.0 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.40 Median:147.50 stddev:6.38 (4.3%) stddev-sans-first:6.00 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 151.0 145.0 152.0 135.0 147.0 146.0 148.0 136.0 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.00 stddev:1.89 (2.7%) stddev-sans-first:2.00 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 74.0 69.0 68.0 69.0 68.0 68.0 68.0 71.0 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:05 INFO - 2015-12-16 16:41:05,382 DEBUG : BROWSER_OUTPUT: 16:41:06 INFO - 2015-12-16 16:41:06,252 INFO : Browser exited with error code: 0 16:41:06 INFO - 2015-12-16 16:41:06,305 INFO : Completed test kraken (00:01:00) 16:41:06 INFO - 2015-12-16 16:41:06,305 INFO : Starting test v8_7 16:41:06 INFO - 2015-12-16 16:41:06,305 DEBUG : operating with platform_type : linux_ 16:41:06 INFO - 2015-12-16 16:41:06,305 INFO : Initialising browser for v8_7 test... 16:41:06 INFO - 2015-12-16 16:41:06,311 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUEfoxT/profile http://localhost:59243/getInfo.html 16:41:10 INFO - 2015-12-16 16:41:10,823 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:41:10 INFO - 2015-12-16 16:41:10,823 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:41:10 INFO - 2015-12-16 16:41:10,823 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:41:10 INFO - 2015-12-16 16:41:10,824 DEBUG : BROWSER_OUTPUT: __metrics 16:41:10 INFO - 2015-12-16 16:41:10,945 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 16:41:11 INFO - 2015-12-16 16:41:11,027 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:41:11 INFO - 2015-12-16 16:41:11,881 INFO : Browser initialized. 16:41:11 INFO - 2015-12-16 16:41:11,882 INFO : Running cycle 1/1 for v8_7 test... 16:41:11 INFO - 2015-12-16 16:41:11,882 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUEfoxT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:41:23 INFO - 2015-12-16 16:41:23,902 DEBUG : BROWSER_OUTPUT: RSS: Main: 142430208 16:41:23 INFO - 2015-12-16 16:41:23,902 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,290 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:59243/tests/v8_7/run.html (next: http://localhost:59243/tests/v8_7/run.html) 16:41:45 INFO - 2015-12-16 16:41:45,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 443011072 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: |0;Richards;165.0709805216243 16:41:45 INFO - 2015-12-16 16:41:45,541 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;188.25301204819277 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2024.2914979757086 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |6;Boyer;12341.463414634147 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |7;RegExp;27459.45945945946 16:41:45 INFO - 2015-12-16 16:41:45,542 DEBUG : BROWSER_OUTPUT: |8;Splay;610.5006105006105 16:41:45 INFO - 2015-12-16 16:41:45,543 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 16:41:45 INFO - 2015-12-16 16:41:45,543 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:41:45 INFO - 2015-12-16 16:41:45,543 DEBUG : BROWSER_OUTPUT: __startTimestamp1450312905540__endTimestamp 16:41:45 INFO - 2015-12-16 16:41:45,543 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,544 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:41:45 INFO - 2015-12-16 16:41:45,544 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:41:45 INFO - 2015-12-16 16:41:45,544 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,544 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.07 Median:165.07 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 165.1 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:188.25 Median:188.25 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 188.3 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 277.9 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 5128.2 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2024.29 Median:2024.29 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 2024.3 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,545 DEBUG : BROWSER_OUTPUT: Values: 794.3 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12341.46 Median:12341.46 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: Values: 12341.5 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27459.46 Median:27459.46 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: Values: 27459.5 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.50 Median:610.50 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: Values: 610.5 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: Values: 4840.6 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:41:45 INFO - 2015-12-16 16:41:45,546 DEBUG : BROWSER_OUTPUT: 16:41:46 INFO - 2015-12-16 16:41:46,440 INFO : Browser exited with error code: 0 16:41:46 INFO - 2015-12-16 16:41:46,457 INFO : Completed test v8_7 (00:00:40) 16:41:46 INFO - 2015-12-16 16:41:46,569 INFO : Completed test suite (00:20:18) 16:41:46 INFO - 2015-12-16 16:41:46,569 DEBUG : Working with test: dromaeo_css 16:41:46 INFO - 2015-12-16 16:41:46,569 DEBUG : Generating results file: dromaeo_css 16:41:46 INFO - 2015-12-16 16:41:46,570 DEBUG : Working with test: kraken 16:41:46 INFO - 2015-12-16 16:41:46,570 DEBUG : Generating results file: kraken 16:41:46 INFO - 2015-12-16 16:41:46,571 INFO : javascript benchmark 16:41:46 INFO - 2015-12-16 16:41:46,571 DEBUG : Working with test: v8_7 16:41:46 INFO - 2015-12-16 16:41:46,571 DEBUG : Generating results file: v8_7 16:41:46 INFO - 2015-12-16 16:41:46,571 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:46 INFO - 2015-12-16 16:41:46,625 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 16:41:46 INFO - 2015-12-16 16:41:46,625 DEBUG : process_Request line: dromaeo_css 6324.69 graph.html#tests=[[72,132,35]] 16:41:46 INFO - 2015-12-16 16:41:46,625 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:46 INFO - 2015-12-16 16:41:46,752 DEBUG : process_Request line: kraken 1528.40 graph.html#tests=[[232,132,35]] 16:41:46 INFO - 2015-12-16 16:41:46,753 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:41:46 INFO - 2015-12-16 16:41:46,878 DEBUG : process_Request line: v8_7 19685.39 graph.html#tests=[[230,132,35]] 16:41:46 INFO - 2015-12-16 16:41:46,879 INFO : javascript benchmark 16:41:46 INFO - 2015-12-16 16:41:46,883 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2631.6315715799788, 2748.7251274872515, 2756.462489814487, 2760.0, 2762.0, 4610.308453731942, 4781.019890922361, 4786.808527658894, 4789.928151077732, 4803.495632958541, 4668.62650987921, 4725.952740472594, 4740.952590474094, 4826.589739872115, 4852.078105160017, 4252.659787217015, 4314.568543145691, 4332.545082766312, 4405.801738921757, 4500.729956202622, 4480.52954439784, 4509.909801803962, 4525.321201819737, 4537.818487260505, 4547.7953492092765, 4218.430511880888, 4298.763568003758, 4313.719608225455, 4407.669424793154, 4443.15580039793, 4393.714408563433, 4399.340098985178, 4400.691951563392, 4405.163019026375, 4437.889052773707, 4360.869173924787, 4378.321360189176, 4385.495667998157, 4388.561143885618, 4403.8458653946955, 4488.551144885518, 4569.794359253841, 4591.311303304497, 4617.191991401492, 4737.170995075882, 5099.643024988252, 5107.693538387709, 5113.284140220372, 5119.308893299394, 5146.536811686966, 5108.463611320833, 5121.51345622169, 5123.231515272739, 5127.1796512558185, 5174.91326821368, 4584.083183363341, 4692.389989301369, 4733.952660473386, 4738.455077666113, 4747.264174053027, 5100.515451032146, 5197.896042079213, 5243.082460569385, 5250.081235783799, 5290.92063619046, 5009.073321435546, 5009.699418034929, 5014.648974571745, 5015.548600625962, 5024.748762561931, 4930.852074437773, 5053.7220452875445, 5097.745112744348, 5099.133147364957, 5148.897022059537, 4967.875803104951, 4981.9252711209365, 4988.650794444354, 5061.924071138936, 5086.338775959101, 5004.149294619923, 5036.521530454601, 5039.949600503948, 5045.41977672565, 5051.823186188466, 4208.095259519157, 4251.043515209053, 4253.425787518708, 4281.828726850891, 4282.764447955392, 3596.9280614387567, 3632.219072899339, 3699.8335074921692, 3716.163863130828, 3729.5151630287887, 4398.824047038082, 4402.0, 4403.471583409947, 4405.823767049346, 4441.666874984389, 5119.078565858107, 5128.461511541234, 5130.410002849645, 5135.15269980449, 5186.196139598368, 4178.080822219107, 4285.207236661166, 4285.678574106954, 4289.914201715948, 4392.802323895432, 4526.388937493396, 4531.77341132942, 4546.340780586796, 4549.977250113794, 4568.200564901129, 4824.131656301899, 4882.389701287339, 4884.316195732529, 4891.364122664031, 4894.583960363409, 4858.708477491362, 4977.651564390458, 4979.477154898684, 4982.252662100714, 5067.569256613229, 4745.928811067905, 4885.682430641997, 4891.266310053378, 4905.337779399735, 4951.5048495150195, 5063.974680126576, 5075.0, 5075.111855425212, 5079.949200507947, 5122.949795292031, 4901.117798796251, 5020.221865610836, 5141.177411614124, 5145.974270128625, 5149.0, 4775.785089670903, 4804.903901922012, 4819.036192761532, 4825.662203645711, 4885.462599114024, 4860.270959356125, 4866.0, 4870.8538743836325, 4890.657653964188, 4911.901761964669, 4658.627309815274, 4756.7145971241835, 4785.665003449864, 4798.256270278112, 4820.228763397839, 4868.780904859361, 4903.730294833818, 4928.581070609039, 4956.454789973028, 4996.475370086088, 4843.515648435128, 4892.8532144035735, 4894.388201474816, 4905.068037072945, 4938.950610493993], "unit": "score", "name": "dojo.html", "value": 4655.766318206032}, {"lowerIsBetter": false, "replicates": [557.2811073714907, 563.0653115827724, 566.4873289672846, 573.4580821124036, 582.065784416012, 27045.72954270457, 27593.862030689845, 35649.2870142597, 36472.0, 36494.27011459769, 40834.38748418769, 41434.0, 41437.0, 41491.0, 41513.58486415135, 7086.511832515178, 7973.720919767809, 8155.836883262331, 8160.673573057071, 8165.918340816575, 7242.0, 7353.264673532631, 9737.51312434379, 9936.652217172401, 9988.550515226832, 10203.132733717643, 10306.536205870716, 10312.845307320396, 10315.587376504931, 10327.27709060366, 7167.534110282815, 7315.195328513859, 10189.388636681786, 10294.0, 10296.588136474495, 10290.125339346165, 10598.523066462029, 10599.152067834555, 10600.098991585724, 10608.681739547827, 37310.25379492395, 37568.24863502714, 37746.62253377486, 37792.62207377919, 37838.621613783784, 2938.3388737534096, 2962.2742428105253, 2989.2825721826607, 3346.7991920484847, 3479.8434070466888, 28676.426471470662, 28708.0, 28929.42141157186, 29103.272418189503, 29745.25636859074, 3286.96713032869, 3335.5663763710804, 3382.6092569879256, 3383.2387712764676, 3395.337909107725, 218288.0, 218630.0, 218652.0, 218864.0, 219070.0, 53122.0, 56984.0, 57501.71249143811, 57582.0, 57585.0, 46867.0, 61415.692921535105, 62310.68844655748, 62767.686161569814, 62773.37226627766, 14435.278236088154, 14674.633134171518, 14689.265536723122, 14693.412263509339, 14700.264986750619, 10522.0, 10622.787544249071, 10659.84010239847, 10660.520276587573, 10665.093467055232, 18825.152868120967, 18896.71654925177, 19062.80937190638, 19076.61846763057, 19901.900490497454, 7452.254774522613, 7736.303732664087, 7738.458307918504, 7816.8827467588035, 7885.093214280317, 850.7235148576614, 853.3375867293959, 898.4519443139679, 996.267743208741, 1031.4945676618404, 26527.336816579354, 26919.865400672872, 27023.324416889736, 27141.1857644271, 27201.72798271992, 954.4845783277092, 993.3940296419179, 1006.4011912911806, 1103.5144536403957, 1149.431031639344, 14285.928570357082, 14362.712745745235, 14410.85589144116, 14459.78310325346, 14570.85429145695, 258588.0, 262735.0, 262910.0, 263010.0, 264075.0, 47129.5287047132, 47558.762206188745, 47586.28620570694, 47606.761966189944, 47623.0, 1243.521244320943, 1249.119370843553, 1251.5431867368527, 1264.7723409786327, 1378.9933348655538, 22340.21809236669, 25480.617790733526, 25948.48103037891, 25983.220503384928, 29798.0, 40828.79585602053, 41168.0, 41386.58613413827, 41510.377344340464, 41534.58465415307, 197712.0, 199396.0, 199598.0, 200213.0, 200328.0, 24089.156879509133, 28197.859010704815, 29362.0, 29563.0, 29651.851740742022, 33677.32645347128, 34172.65827341794, 34408.0, 34865.0, 34978.0, 29550.261243469085, 29750.702492974793, 32766.50850237296, 33775.3244935095, 34382.14044648904, 32625.551056680335, 33161.83419082889, 33385.499217512246, 33400.16499587432, 33686.66313336933, 32857.835710821295, 32948.341033179684, 33063.17342066467, 33289.334213316084, 33418.66581334253, 28556.0, 29269.26826829261, 30159.547606786353, 30512.694873050987, 30561.694383055885, 23552.6467102997, 23985.640215396434, 24075.277741667778, 24151.637725433782, 24307.27078187657], "unit": "score", "name": "ext.html", "value": 17230.880888547574}, {"lowerIsBetter": false, "replicates": [327.11841586923254, 327.19510005386735, 328.0764647517239, 332.06523635964766, 332.58593051650695, 12175.756484870297, 12548.937255313711, 15026.0, 15547.22263886804, 15567.29947152378, 13114.213147211174, 14227.790637795773, 15843.12862792546, 16598.917005414954, 16631.584210394747, 5083.7712302946275, 5089.491050894918, 5090.389153301609, 5118.669146022043, 5148.871278218037, 3852.0947577319307, 3943.940840887389, 5112.386513618371, 5155.948440515603, 5814.331351894544, 5934.495567876714, 5951.285845698522, 5972.79095231667, 5977.910331345033, 5978.790742324019, 5855.79504717335, 6018.759249630009, 6053.0, 6064.302605200414, 6069.757209711606, 5303.257543943851, 5315.681059136464, 5329.520343169094, 5331.147016477384, 5338.759755810997, 19467.513312167168, 19682.90158549198, 19879.30422435222, 20402.0, 20417.97910104489, 1929.9324523641606, 1964.72493850861, 2147.8281737460966, 2318.6058370077126, 2587.133310341038, 13055.543055992996, 13147.802782958168, 13150.276734779583, 13459.394327255297, 13605.727885442335, 1731.852792512638, 1748.7027205375116, 1762.4448298785842, 1797.3888877781487, 1859.7768267807949, 52893.0, 55563.72218138924, 55573.16640250399, 55664.443355566335, 56375.15437268444, 9578.712638620853, 9643.855342169873, 9778.07108324708, 9815.460149691835, 9841.261905357127, 12507.312097834525, 12509.812352814715, 12518.81221781674, 12534.310612916195, 12557.93721031389, 7342.622493322119, 7370.152432470228, 7408.664234705861, 7446.73936412223, 7492.887606685904, 7069.9646501767165, 7085.50401471892, 7088.751893683696, 7089.53917995339, 7111.857762844714, 5721.542276617861, 5806.738696758656, 5918.615290006222, 5961.539422841432, 5986.9401305986385, 1584.5563242292176, 1652.7190377635832, 1657.2128239086337, 1681.2014293210627, 1687.5190570687296, 373.76452834713956, 796.6892911764417, 837.3552364679163, 884.4648987362682, 934.7102398256562, 9258.90741092594, 9292.581833817494, 9557.996410376949, 9584.76038099053, 9744.610215591298, 378.8049154685339, 408.65672834818895, 410.65504975820454, 417.6387424877459, 419.97690127042694, 5080.949190508121, 5190.480951904779, 5198.870028249324, 5240.947590524046, 5317.0, 468166.0, 472706.0, 474650.0, 485022.0, 492354.0, 66412.66793666001, 66696.0, 67298.0, 72477.0, 72905.63547182336, 434.2639226511097, 442.24376316498507, 447.29550957242475, 450.223364695897, 452.2041207474868, 9551.808963820824, 13970.650733731738, 13987.790183147465, 14576.416943322149, 14579.92710036443, 31525.684743152276, 32096.67903320937, 32214.838925806158, 32414.189645259055, 34650.0, 41827.58172418237, 41971.58028419677, 42852.78573607112, 43037.3544396828, 43056.35415468708, 9175.77060573491, 9203.447793132433, 9390.342676012613, 9394.859077113711, 9409.200217981548, 10852.511636976196, 13798.517051903134, 16778.832211678215, 17008.14959252057, 17222.655546889244, 14172.645683857574, 14198.645033874236, 14421.134731916118, 14625.122492650475, 14654.78017829712, 13776.188145024822, 13871.930640346734, 14020.929895350459, 14213.076150050214, 14482.493112741004, 10332.431716255678, 14403.711925761636, 14420.711585768435, 14755.114693118447, 14885.255737213312, 9051.59267832936, 9148.176664100263, 9211.447313161232, 9445.574949127444, 9451.669191578261, 13911.0, 14062.929685351508, 14203.360848761624, 14476.0, 14608.415663373346], "unit": "score", "name": "jquery.html", "value": 7950.200578350756}, {"lowerIsBetter": false, "replicates": [1232.4515590562203, 1414.6039109049464, 1425.7077299153668, 1631.7144499712547, 1703.7444383342502, 6246.094316324136, 7084.574925504473, 7204.60374679393, 7246.492745507817, 7267.636618169096, 7020.403265722407, 7166.283371662831, 7176.748813791505, 7181.425485961124, 7200.063991681074, 1734.670412621604, 1760.5070580237555, 2051.1385218208316, 2090.205721825704, 2130.52063285761, 2076.169532187122, 2080.365488525999, 2081.4172031831113, 2086.113401804227, 2087.1651339464183, 2030.6649402848511, 2065.7624373197123, 2118.8622739521957, 2119.607872543577, 2121.501447159916, 2083.7916208379193, 2094.3088780702333, 2117.925872594452, 2118.9576208475823, 2142.218090396994, 2106.3996760923064, 2126.223928266187, 2152.5049238675037, 2154.849160558746, 2154.9030293636665, 7014.4739144563855, 7125.25184855593, 7125.643717814089, 7132.037174981363, 7134.500584959055, 4178.582141785828, 4249.46881639795, 4254.340577210537, 4273.636740877029, 4274.551172126944, 2663.0546156114688, 2704.161709869927, 2724.5913113033007, 2736.808423410362, 2765.046059109604, 840.3193413335157, 841.2260720137489, 846.9153084691543, 865.446114486729, 867.4361664917791, 9618.615255389775, 9620.807583848355, 9622.0, 9624.615015399446, 9634.229261659051, 3873.535175778868, 3882.8446862125766, 3926.1166237596312, 3939.940900886489, 3944.1717239379477, 8240.958795205986, 8261.793455163668, 8268.09051004389, 8269.875951860728, 8295.585220738938, 4250.872473825791, 4251.681123915719, 4252.936205956913, 4256.297710877732, 4263.701540892108, 3802.3535998880257, 3820.1977584707524, 3832.2335532893535, 3861.1505468796818, 3867.806609669505, 2954.6749857515656, 2959.4377068356944, 3066.340736741611, 3438.535797667333, 3478.4956181353564, 1103.9834402483968, 1140.2702270546856, 1142.8114361130486, 1143.2511704833348, 1147.3632134165618, 964.4936408385654, 1042.4579218806177, 1170.7073231692077, 1212.89083982442, 1213.77545154145, 6768.255491895888, 6822.897656535156, 6839.247682754893, 6843.418309443753, 6848.0, 1028.6091285311534, 1043.212374657129, 1050.1703654113317, 1060.2737125069352, 1075.7794652096302, 5318.494742999486, 5424.945750542444, 5428.0, 5431.293931788921, 5437.45625437461, 8428.747137585882, 8567.957160214284, 8804.47173169612, 8903.866442003375, 8911.420757650732, 8702.608382622671, 8751.693690720795, 8773.298136149093, 8781.560921953876, 8805.559722014003, 6687.565308254948, 6783.728650854009, 6849.760258391032, 6858.759943401957, 6860.485463590251, 6599.868002640016, 6635.0710900473005, 6655.767048153291, 6667.666616669244, 6673.432758215412, 7646.235376462309, 7776.961115194614, 7845.097813751491, 7904.407169462198, 7921.366290696616, 7889.960550197442, 8011.158828323175, 8094.352451803724, 8101.513909165469, 8206.0, 6329.303776584664, 6347.841303967438, 6394.58435201729, 6395.040743888454, 6396.42432181106, 5627.493525582717, 5973.313068997121, 6520.217573891164, 6756.763513277012, 6840.692168852314, 6342.112104305309, 6511.316311787384, 6563.310852360433, 6639.734410623521, 6674.733010679518, 6295.370462953668, 6319.778807741707, 6349.301576826638, 6424.93575064262, 6538.1500404947055, 6485.0596663484475, 6516.185476815398, 6523.086767852599, 6530.314316996647, 6547.214334279917, 6096.268447786294, 6123.632582045091, 6129.662868542273, 6130.540209484396, 6137.3248942617165, 5865.618734782225, 6070.816190842744, 6079.209702738793, 6147.907781383194, 6182.412670796267], "unit": "score", "name": "mootools.html", "value": 4124.64531590974}, {"lowerIsBetter": false, "replicates": [302.8289016705561, 303.44469620594316, 308.837860123435, 311.1893517387206, 312.03892012601176, 5234.371875374955, 5312.0, 5452.073147564914, 5463.726813659316, 5470.370907345657, 5268.604854635908, 5302.151655735083, 5337.039332920082, 5337.946620533793, 5345.01117293301, 3885.873096801938, 3980.6616437602693, 4114.650254728344, 4114.958850411503, 4115.382692596105, 3954.5649978502342, 4053.250148722496, 4072.8370865165507, 4073.2260870434525, 4087.3664581989838, 4016.959830401702, 4018.557958624549, 4025.8188381522755, 4028.939565906514, 4035.273650742865, 3849.788261645608, 3919.960800391988, 3935.5670876203594, 4026.3557830747086, 4036.8183431745642, 3502.176988407722, 3509.859605615798, 3512.262424890776, 3514.578250609943, 3517.525134106914, 5064.215046667772, 5066.949330506684, 5075.568576670988, 5086.084504789136, 5090.847274581732, 4569.748663823489, 4605.930911036304, 4607.585317321457, 4611.654125940568, 4621.468531118897, 5369.677819330853, 5508.669479831223, 5516.668999860021, 5521.696306703129, 5526.917096243559, 3814.4278358246206, 3834.3673293906472, 3837.8656747014, 3840.2895464339185, 3843.6540711335833, 5757.309122905236, 5841.386654401269, 5841.503472204868, 5844.561657875676, 5847.619904706181, 3966.147278335172, 3971.72197946141, 3973.8013099344917, 3976.4830572025453, 3977.54258260298, 3899.3566061599518, 4028.254772867029, 4037.6971727120585, 4039.656629186552, 4040.070783719761, 4568.109218702388, 4606.907861842745, 4607.562281583244, 4613.95386046142, 4615.746133962597, 5548.056830338852, 5548.334199896039, 5552.41699621542, 5554.833354999357, 5562.137868630369, 1415.497498388078, 1435.181946290625, 1435.2751860310477, 1435.4186554445466, 1436.1311406599066, 943.8018016216535, 946.6118891254553, 963.0706368354571, 966.7631430299481, 969.937917979811, 4899.681520701143, 4905.141600219948, 4908.337374454403, 4914.311996320518, 4915.508449155127, 5760.107183386582, 5767.798127065533, 5780.393058728773, 5782.10377391505, 5785.826425207167, 4890.0, 4906.607471402351, 4906.779194936165, 4912.852614421573, 4915.238138088602, 3034.969650303469, 3083.2137804859617, 3113.6263648361887, 3116.283254851397, 3118.3607360491496, 5508.283923089973, 5512.448755124456, 5513.062779327524, 5524.309461317335, 5531.917021244684, 5952.077427998667, 5962.791302304398, 5964.552658550626, 5982.1325907744, 5989.460948514655, 5520.420355862657, 5532.948739739437, 5534.4742249486235, 5541.750621222055, 5544.667319960815, 5669.858253543694, 5776.595638305278, 5826.504747096375, 5833.183354330312, 5837.883242335214, 5682.204491371129, 5683.147527870852, 5683.687397193194, 5691.288588926384, 5692.430756924275, 5525.696086715108, 5529.529989950899, 5530.5022547970875, 5531.308586426697, 5533.529649979636, 3903.4535165076345, 3965.2466031453932, 3966.5835087315418, 3984.6613037892103, 4004.439378487072, 5811.099279611667, 5819.70901454934, 5821.446962538552, 5822.534197264124, 5824.15549745293, 5566.944330556643, 5574.9163762542785, 5575.219469274386, 5577.358603760619, 5582.162675598693, 5571.08077167279, 5581.916271255853, 5595.104783234663, 5595.300587426572, 5604.383517812956, 5329.280547126088, 5424.2406063151975, 5470.699111548903, 5476.2607048048, 5478.589105817, 5308.336457942757, 5484.095124304445, 5564.721763911869, 5574.609777315712, 5614.24207731951, 5349.866253343697, 5463.180522921593, 5489.945100549103, 5502.202180683698, 5504.091824849015], "unit": "score", "name": "prototype.html", "value": 4173.228119697008}, {"lowerIsBetter": false, "replicates": [653.8986457099148, 699.405505320478, 709.5139829216987, 723.0203074833598, 748.648135376373, 11989.160758746892, 12348.81476777848, 12350.073744469157, 12396.38018099096, 12548.937255313711, 13549.458021679146, 13632.0, 13651.795223071662, 13659.863401365983, 13672.453101875913, 645.5190882792326, 651.609034579251, 655.2235600813028, 822.1696086952162, 834.1075049696827, 813.3899575318511, 816.3917881178501, 819.573821612761, 824.1470078468786, 826.0830478169228, 812.8618134917049, 861.444368382393, 872.7905302727363, 874.903760586335, 874.9387542872001, 666.2870728320698, 677.7966610016999, 849.7195925344621, 865.5715420866649, 866.969656062038, 640.4204195203348, 640.679660169915, 640.9230892292954, 641.0064400179702, 641.2785616181795, 12061.155719099579, 12198.329091899943, 12227.266364018187, 12230.082743794163, 12237.877621223763, 10673.1995100367, 11061.944690276578, 11142.777144457066, 11151.330920144736, 11188.608398706006, 9076.593974686506, 9314.90685093154, 9476.620935162586, 9487.525623718855, 9580.856287155699, 3190.5692731481417, 3227.160938156073, 3234.4986527088104, 3277.8197199154038, 3287.589051368579, 40423.7978810104, 40476.0, 40707.38938915889, 40721.28098863684, 40738.59261407348, 8864.157904999014, 8901.777455563662, 8971.192592666692, 9084.772880678036, 9131.543422828832, 15594.9220253898, 15605.141717205663, 15605.453809116854, 15606.9219653901, 15614.141222232885, 6130.264368275835, 6137.447629713347, 6286.245650521875, 6335.968320158462, 6620.271770105284, 3312.38720836646, 3343.8996830095134, 3417.974607617705, 3505.964940350615, 3532.876349327761, 2537.2895589235045, 2594.8971687032936, 2595.5976823592373, 2596.0135148643394, 2601.1806281021795, 429.225248426593, 432.09907343189803, 437.7482947305312, 444.97330160189847, 445.0209539014182, 560.7280468972546, 576.9192313076172, 581.8831765260712, 596.9522438204933, 618.6628287583278, 7774.533527988338, 7901.170377110436, 8070.878936815952, 8077.7576672699915, 8175.305099066527, 600.3816069448475, 600.7566935391174, 606.3633185155569, 608.5739982012609, 617.7528988404584, 3688.5758137814496, 4007.6192761687594, 4063.146739184804, 4066.0038290618986, 4202.957970420318, 49668.75165624149, 51735.0, 52042.0, 52075.0, 52096.47903520992, 40120.0, 40135.79932100379, 40155.39766903499, 40279.798601007395, 40738.79630601828, 42303.73500354653, 43221.567784321756, 43446.348304775456, 43820.78089609532, 44077.55922440799, 8191.385646076687, 8409.95795021021, 8442.0, 8553.74338769838, 8609.526476043879, 31571.842140789147, 32169.195770105936, 32433.51349729803, 32515.187120321236, 32597.674023259464, 36014.639853601126, 37037.0, 38763.41854872236, 40419.39370909498, 40488.59511404848, 10806.567737290421, 10836.0, 11048.116150707763, 11080.445977701243, 11113.833292500458, 12002.39988000614, 12174.330411827434, 12322.32227227511, 12786.104972652198, 12835.743285134431, 10526.210534210119, 11435.428228588704, 11517.884821151682, 11527.250728702607, 11890.46492907804, 10990.890091098987, 11100.389478578756, 11617.825732614187, 11670.241434306743, 12037.939810300892, 11119.722006949567, 11244.887551124712, 11336.319820810448, 11523.884761152616, 11752.941235293769, 9169.862452063091, 9825.606975720892, 10174.949125254327, 10237.590496380062, 10357.882990594684, 8968.506732129796, 9586.66446674363, 9782.706518804447, 9790.411709065791, 9793.331250279172], "unit": "score", "name": "yui.html", "value": 5829.802733350893}], "name": "dromaeo_css", "value": 6324.687149999122}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 116.0, 109.0, 114.0, 114.0, 113.0, 103.0, 118.0, 114.0, 109.0], "unit": "score", "name": "ai-astar", "value": 112.3}, {"lowerIsBetter": true, "replicates": [165.0, 130.0, 151.0, 172.0, 141.0, 155.0, 154.0, 131.0, 172.0, 139.0], "unit": "score", "name": "audio-beat-detection", "value": 151.0}, {"lowerIsBetter": true, "replicates": [161.0, 160.0, 161.0, 160.0, 163.0, 160.0, 162.0, 161.0, 160.0, 160.0], "unit": "score", "name": "audio-dft", "value": 160.8}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 90.0, 93.0, 72.0, 74.0, 72.0, 105.0, 90.0, 72.0], "unit": "score", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 131.0, 95.0, 94.0, 95.0, 129.0, 94.0, 94.0, 129.0], "unit": "score", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 148.0], "unit": "score", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 73.0, 71.0, 72.0, 73.0, 72.0, 82.0, 70.0, 71.0], "unit": "score", "name": "json-parse-financial", "value": 72.9}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 68.0, 68.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [86.0, 86.0, 86.0, 86.0, 87.0, 86.0, 84.0, 85.0, 87.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [121.0, 130.0, 130.0, 117.0, 120.0, 121.0, 132.0, 135.0, 123.0, 123.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 151.0, 145.0, 152.0, 135.0, 147.0, 146.0, 148.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 144.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 74.0, 69.0, 68.0, 69.0, 68.0, 68.0, 68.0, 71.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1528.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.0709805216243], "unit": "score", "name": "Richards", "value": 213.85951599999999}, {"lowerIsBetter": false, "replicates": [188.25301204819277], "unit": "score", "name": "DeltaBlue", "value": 351.2188160000002}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [2024.2914979757086], "unit": "score", "name": "RayTrace", "value": 365.55456600000014}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [12341.463414634147], "unit": "score", "name": "Boyer", "value": 54.00194268774702}, {"lowerIsBetter": false, "replicates": [27459.45945945946], "unit": "score", "name": "RegExp", "value": 33.17563484251969}, {"lowerIsBetter": false, "replicates": [610.5006105006105], "unit": "score", "name": "Splay", "value": 133.48225799999997}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19685.391167810634}]} 16:41:46 INFO - RETURN: dromaeo_css: 6324.69 16:41:46 INFO - RETURN: kraken: 1528.40 16:41:46 INFO - RETURN: v8_7: 19685.39 16:41:46 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19685.39"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6324.69"}}} 16:41:46 INFO - Return code: 0 16:41:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 16:41:47 INFO - # TBPL SUCCESS # 16:41:47 INFO - Running post-action listener: _resource_record_post_action 16:41:47 INFO - Running post-run listener: _resource_record_post_run 16:41:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 0; Write bytes: 523268096; Read time: 0; Write time: 450872 16:41:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 249192448; Read time: 0; Write time: 288052 16:41:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 274075648; Read time: 0; Write time: 162820 16:41:48 INFO - Running post-run listener: _upload_blobber_files 16:41:48 INFO - Blob upload gear active. 16:41:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:41:48 INFO - Copying logs to upload dir... 16:41:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.226471 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-16 16:41:47.850090) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:41:47.853771) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010005 build_url: 'https://queue.taskcluster.net/v1/task/t4Jl_6j9SGuGSWFv2aKm4g/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-16 16:41:47.904415) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:41:47.904755) ========= 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=d333f129428bd91e5d9d687c000001bd-1450310668.703627-1443846588 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004528 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-16 16:41:47.954543) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 16:41:47.955059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-16 16:41:47.955551) ========= ========= Total master_lag: 0.24 =========