builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-019 starttime: 1450350094.3 results: success (0) buildid: 20151217022032 builduid: a3b561e232e84b94a5d1851a68aae9ed revision: 1e4c936c142d5d13da442e8a82d4f30a40971153 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.300407) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.300856) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.301140) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006358 basedir: '/builds/slave/test' ========= master_lag: 0.17 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.478504) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.478860) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.572076) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.572356) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004499 ========= master_lag: 0.09 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.671465) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.671745) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.672093) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.672753) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-17 03:01:35-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 62.6M=0s 2015-12-17 03:01:35 (62.6 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.135108 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.832557) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.833067) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017942 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:34.888272) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 03:01:34.888839) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 1e4c936c142d5d13da442e8a82d4f30a40971153 --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 1e4c936c142d5d13da442e8a82d4f30a40971153 --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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-17 03:01:35,293 truncating revision to first 12 chars 2015-12-17 03:01:35,294 Setting DEBUG logging. 2015-12-17 03:01:35,294 attempt 1/10 2015-12-17 03:01:35,294 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/1e4c936c142d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-17 03:01:36,384 unpacking tar archive at: fx-team-1e4c936c142d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.380317 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-17 03:01:36.284916) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.285181) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.295312) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.295660) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-17 03:01:36.296082) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 03:01:36.296422) ========= /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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:01:36 INFO - MultiFileLogger online at 20151217 03:01:36 in /builds/slave/test 03:01:36 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 03:01:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:01:36 INFO - {'append_to_log': False, 03:01:36 INFO - 'base_work_dir': '/builds/slave/test', 03:01:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 03:01:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:01:36 INFO - 'branch': 'Fx-Team-Non-PGO', 03:01:36 INFO - 'buildbot_json_path': 'buildprops.json', 03:01:36 INFO - 'config_files': ('talos/linux_config.py',), 03:01:36 INFO - 'default_actions': ('clobber', 03:01:36 INFO - 'read-buildbot-config', 03:01:36 INFO - 'download-and-extract', 03:01:36 INFO - 'populate-webroot', 03:01:36 INFO - 'create-virtualenv', 03:01:36 INFO - 'install', 03:01:36 INFO - 'run-tests'), 03:01:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:01:36 INFO - 'download_minidump_stackwalk': True, 03:01:36 INFO - 'download_symbols': 'ondemand', 03:01:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:01:36 INFO - 'tooltool.py': '/tools/tooltool.py', 03:01:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:01:36 INFO - '/tools/misc-python/virtualenv.py')}, 03:01:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:01:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:01:36 INFO - 'installer_path': 'installer.exe', 03:01:36 INFO - 'log_level': 'info', 03:01:36 INFO - 'log_name': 'talos', 03:01:36 INFO - 'log_to_console': True, 03:01:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:01:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:01:36 INFO - 'opt_config_files': (), 03:01:36 INFO - 'pip_index': False, 03:01:36 INFO - 'sps_profile': False, 03:01:36 INFO - 'sps_profile_interval': 0, 03:01:36 INFO - 'suite': 'dromaeojs', 03:01:36 INFO - 'system_bits': '64', 03:01:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:01:36 INFO - 'title': 'talos-linux64-ix-019', 03:01:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:01:36 INFO - 'use_talos_json': True, 03:01:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:01:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:01:36 INFO - 'work_dir': 'build'} 03:01:36 INFO - ##### 03:01:36 INFO - ##### Running clobber step. 03:01:36 INFO - ##### 03:01:36 INFO - Running pre-action listener: _resource_record_pre_action 03:01:36 INFO - Running main action method: clobber 03:01:36 INFO - rmtree: /builds/slave/test/build 03:01:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:01:37 INFO - Running post-action listener: _resource_record_post_action 03:01:37 INFO - ##### 03:01:37 INFO - ##### Running read-buildbot-config step. 03:01:37 INFO - ##### 03:01:37 INFO - Running pre-action listener: _resource_record_pre_action 03:01:37 INFO - Running main action method: read_buildbot_config 03:01:37 INFO - Using buildbot properties: 03:01:37 INFO - { 03:01:37 INFO - "project": "", 03:01:37 INFO - "product": "firefox", 03:01:37 INFO - "script_repo_revision": "production", 03:01:37 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 03:01:37 INFO - "repository": "", 03:01:37 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 03:01:37 INFO - "buildid": "20151217022032", 03:01:37 INFO - "pgo_build": "False", 03:01:37 INFO - "basedir": "/builds/slave/test", 03:01:37 INFO - "buildnumber": 1019, 03:01:37 INFO - "slavename": "talos-linux64-ix-019", 03:01:37 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:01:37 INFO - "platform": "ubuntu64_hw", 03:01:37 INFO - "scheduler": "tests-fx-team-linux64-talos", 03:01:37 INFO - "branch": "fx-team", 03:01:37 INFO - "repo_path": "integration/fx-team", 03:01:37 INFO - "revision": "1e4c936c142d5d13da442e8a82d4f30a40971153", 03:01:37 INFO - "stage_platform": "linux64", 03:01:37 INFO - "builduid": "a3b561e232e84b94a5d1851a68aae9ed", 03:01:37 INFO - "slavebuilddir": "test" 03:01:37 INFO - } 03:01:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2. 03:01:37 INFO - Running post-action listener: _resource_record_post_action 03:01:37 INFO - ##### 03:01:37 INFO - ##### Running download-and-extract step. 03:01:37 INFO - ##### 03:01:37 INFO - Running pre-action listener: _resource_record_pre_action 03:01:37 INFO - Running main action method: download_and_extract 03:01:37 INFO - mkdir: /builds/slave/test/build/tests 03:01:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:37 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:01:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json 03:01:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json 03:01:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:01:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:01:44 INFO - Downloaded 1302 bytes. 03:01:44 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:01:44 INFO - Using the following test package requirements: 03:01:44 INFO - {u'common': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:44 INFO - u'cppunittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:01:44 INFO - u'jittest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'jsshell-linux-x86_64.zip'], 03:01:44 INFO - u'mochitest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:01:44 INFO - u'mozbase': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:44 INFO - u'reftest': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:01:44 INFO - u'talos': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:01:44 INFO - u'web-platform': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:01:44 INFO - u'webapprt': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'], 03:01:44 INFO - u'xpcshell': [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip', 03:01:44 INFO - u'firefox-46.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:01:44 INFO - Downloading packages: [u'firefox-46.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:01:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:44 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:46 INFO - Downloaded 21869235 bytes. 03:01:46 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 03:01:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:46 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 03:01:47 INFO - Return code: 0 03:01:47 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 03:01: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')]} 03:01:47 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:01:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:48 INFO - Downloaded 21869235 bytes. 03:01:48 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 03:01:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.common.tests.zip 03:01:48 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 03:01:49 INFO - Return code: 0 03:01:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:49 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:01:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:50 INFO - Downloaded 11132052 bytes. 03:01:50 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 03:01:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-46.0a1.en-US.linux-x86_64.talos.tests.zip 03:01:50 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 03:01:50 INFO - Return code: 0 03:01:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:50 INFO - https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:01:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1_zXqISXSyiItZR_-bz7OA/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 03:01:51 INFO - Downloaded 57772358 bytes. 03:01:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:51 INFO - mkdir: /builds/slave/test/properties 03:01:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:01:51 INFO - Writing to file /builds/slave/test/properties/build_url 03:01:51 INFO - Contents: 03:01:51 INFO - build_url:https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 03:01:51 INFO - Running post-action listener: _resource_record_post_action 03:01:51 INFO - Running post-action listener: set_extra_try_arguments 03:01:51 INFO - ##### 03:01:51 INFO - ##### Running populate-webroot step. 03:01:51 INFO - ##### 03:01:51 INFO - Running pre-action listener: _resource_record_pre_action 03:01:51 INFO - Running main action method: populate_webroot 03:01:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:01:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:01:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:01:51 INFO - '--tppagecycles', 03:01:51 INFO - '7'], 03:01:51 INFO - 'tests': ['tsvgm']}}, 03:01:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:01:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:01:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:01:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:01:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'tests': ['damp', 'tps']}, 03:01:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['damp', 'tps']}, 03:01:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:01:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:01:51 INFO - 'other': {'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'other_l64': {'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'other_nol64': {'tests': ['a11yr', 03:01:51 INFO - 'ts_paint', 03:01:51 INFO - 'tpaint', 03:01:51 INFO - 'sessionrestore', 03:01:51 INFO - 'sessionrestore_no_auto_restore']}, 03:01:51 INFO - 'svgr': {'tests': ['tsvgx', 03:01:51 INFO - 'tsvgr_opacity', 03:01:51 INFO - 'tart', 03:01:51 INFO - 'tscrollx', 03:01:51 INFO - 'cart']}, 03:01:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['tsvgx', 03:01:51 INFO - 'tsvgr_opacity', 03:01:51 INFO - 'tart', 03:01:51 INFO - 'tscrollx', 03:01:51 INFO - 'cart']}, 03:01:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'tests': ['tp5o']}, 03:01:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'talos_options': ['--e10s'], 03:01:51 INFO - 'tests': ['tp5o']}, 03:01:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'talos_options': ['--xperf_path', 03:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:51 INFO - 'tests': ['tp5n']}, 03:01:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:01:51 INFO - 'talos_options': ['--e10s', 03:01:51 INFO - '--xperf_path', 03:01:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:01:51 INFO - 'tests': ['tp5n']}}, 03:01:51 INFO - 'talos.zip': {'path': '', 03:01:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:01:51 INFO - Running post-action listener: _resource_record_post_action 03:01:51 INFO - ##### 03:01:51 INFO - ##### Running create-virtualenv step. 03:01:51 INFO - ##### 03:01:51 INFO - Running pre-action listener: _resource_record_pre_action 03:01:51 INFO - Running main action method: create_virtualenv 03:01:51 INFO - Creating virtualenv /builds/slave/test/build/venv 03:01:51 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:01:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:01:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:01:51 INFO - Using real prefix '/usr' 03:01:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:01:52 INFO - Installing distribute.............................................................................................................................................................................................done. 03:01:54 INFO - Installing pip.................done. 03:01:54 INFO - Return code: 0 03:01:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:01: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', 'pip>=1.5'] in /builds/slave/test/build 03:01: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 pip>=1.5 03:01:54 INFO - Using env: {'DISPLAY': ':0', 03:01:54 INFO - 'HOME': '/home/cltbld', 03:01:54 INFO - 'LANG': 'en_US.UTF-8', 03:01:54 INFO - 'LANGUAGE': 'en_US:en', 03:01:54 INFO - 'LOGNAME': 'cltbld', 03:01:54 INFO - 'MAIL': '/var/mail/cltbld', 03:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:54 INFO - 'MOZ_NO_REMOTE': '1', 03:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:54 INFO - 'NO_EM_RESTART': '1', 03:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:54 INFO - 'PWD': '/builds/slave/test', 03:01:54 INFO - 'SHELL': '/bin/bash', 03:01:54 INFO - 'SHLVL': '1', 03:01:54 INFO - 'TERM': 'linux', 03:01:54 INFO - 'TMOUT': '86400', 03:01:54 INFO - 'USER': 'cltbld', 03:01:54 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:54 INFO - '_': '/tools/buildbot/bin/python'} 03:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:54 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 03:01:54 INFO - Cleaning up... 03:01:54 INFO - Return code: 0 03:01:54 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:01: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')]} 03:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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')]} 03:01:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01: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', '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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:01: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', 'psutil>=0.7.1'] in /builds/slave/test/build 03:01: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 psutil>=0.7.1 03:01:54 INFO - Using env: {'DISPLAY': ':0', 03:01:54 INFO - 'HOME': '/home/cltbld', 03:01:54 INFO - 'LANG': 'en_US.UTF-8', 03:01:54 INFO - 'LANGUAGE': 'en_US:en', 03:01:54 INFO - 'LOGNAME': 'cltbld', 03:01:54 INFO - 'MAIL': '/var/mail/cltbld', 03:01:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:54 INFO - 'MOZ_NO_REMOTE': '1', 03:01:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:54 INFO - 'NO_EM_RESTART': '1', 03:01:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:54 INFO - 'PWD': '/builds/slave/test', 03:01:54 INFO - 'SHELL': '/bin/bash', 03:01:54 INFO - 'SHLVL': '1', 03:01:54 INFO - 'TERM': 'linux', 03:01:54 INFO - 'TMOUT': '86400', 03:01:54 INFO - 'USER': 'cltbld', 03:01:54 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:01:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:54 INFO - '_': '/tools/buildbot/bin/python'} 03:01:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:54 INFO - Downloading/unpacking psutil>=0.7.1 03:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:01:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:01:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:01:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:01:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:01:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:01:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:56 INFO - Installing collected packages: psutil 03:01:56 INFO - Running setup.py install for psutil 03:01:56 INFO - building 'psutil._psutil_linux' extension 03:01:56 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 03:01:56 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:01:56 INFO - building 'psutil._psutil_posix' extension 03:01:56 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:01:57 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 03:01:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:01:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:01:57 INFO - Successfully installed psutil 03:01:57 INFO - Cleaning up... 03:01:57 INFO - Return code: 0 03:01:57 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:01:57 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')]} 03:01:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:57 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')]} 03:01:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:57 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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:01:57 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 03:01:57 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 03:01:57 INFO - Using env: {'DISPLAY': ':0', 03:01:57 INFO - 'HOME': '/home/cltbld', 03:01:57 INFO - 'LANG': 'en_US.UTF-8', 03:01:57 INFO - 'LANGUAGE': 'en_US:en', 03:01:57 INFO - 'LOGNAME': 'cltbld', 03:01:57 INFO - 'MAIL': '/var/mail/cltbld', 03:01:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:57 INFO - 'MOZ_NO_REMOTE': '1', 03:01:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:57 INFO - 'NO_EM_RESTART': '1', 03:01:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:57 INFO - 'PWD': '/builds/slave/test', 03:01:57 INFO - 'SHELL': '/bin/bash', 03:01:57 INFO - 'SHLVL': '1', 03:01:57 INFO - 'TERM': 'linux', 03:01:57 INFO - 'TMOUT': '86400', 03:01:57 INFO - 'USER': 'cltbld', 03:01:57 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:01:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:57 INFO - '_': '/tools/buildbot/bin/python'} 03:01:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:57 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01:59 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:01:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:01:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:01:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:01:59 INFO - Installing collected packages: mozsystemmonitor 03:01:59 INFO - Running setup.py install for mozsystemmonitor 03:01:59 INFO - Successfully installed mozsystemmonitor 03:01:59 INFO - Cleaning up... 03:01:59 INFO - Return code: 0 03:01:59 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:01:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:01:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:01:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:01:59 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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:01:59 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 03:01:59 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 03:01:59 INFO - Using env: {'DISPLAY': ':0', 03:01:59 INFO - 'HOME': '/home/cltbld', 03:01:59 INFO - 'LANG': 'en_US.UTF-8', 03:01:59 INFO - 'LANGUAGE': 'en_US:en', 03:01:59 INFO - 'LOGNAME': 'cltbld', 03:01:59 INFO - 'MAIL': '/var/mail/cltbld', 03:01:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:01:59 INFO - 'MOZ_NO_REMOTE': '1', 03:01:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:01:59 INFO - 'NO_EM_RESTART': '1', 03:01:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:01:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:01:59 INFO - 'PWD': '/builds/slave/test', 03:01:59 INFO - 'SHELL': '/bin/bash', 03:01:59 INFO - 'SHLVL': '1', 03:01:59 INFO - 'TERM': 'linux', 03:01:59 INFO - 'TMOUT': '86400', 03:01:59 INFO - 'USER': 'cltbld', 03:01:59 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:01:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:01:59 INFO - '_': '/tools/buildbot/bin/python'} 03:01:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:01:59 INFO - Downloading/unpacking blobuploader==1.2.4 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:01: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 03:02:01 INFO - Downloading blobuploader-1.2.4.tar.gz 03:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:02:01 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:02:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 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 03:02:01 INFO - Downloading docopt-0.6.1.tar.gz 03:02:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:02:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:02:01 INFO - Installing collected packages: blobuploader, requests, docopt 03:02:01 INFO - Running setup.py install for blobuploader 03:02:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:02:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:02:01 INFO - Running setup.py install for requests 03:02:02 INFO - Running setup.py install for docopt 03:02:02 INFO - Successfully installed blobuploader requests docopt 03:02:02 INFO - Cleaning up... 03:02:02 INFO - Return code: 0 03:02:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:02 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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:02:02 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 03:02:02 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 03:02:02 INFO - Using env: {'DISPLAY': ':0', 03:02:02 INFO - 'HOME': '/home/cltbld', 03:02:02 INFO - 'LANG': 'en_US.UTF-8', 03:02:02 INFO - 'LANGUAGE': 'en_US:en', 03:02:02 INFO - 'LOGNAME': 'cltbld', 03:02:02 INFO - 'MAIL': '/var/mail/cltbld', 03:02:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:02 INFO - 'MOZ_NO_REMOTE': '1', 03:02:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:02 INFO - 'NO_EM_RESTART': '1', 03:02:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:02 INFO - 'PWD': '/builds/slave/test', 03:02:02 INFO - 'SHELL': '/bin/bash', 03:02:02 INFO - 'SHLVL': '1', 03:02:02 INFO - 'TERM': 'linux', 03:02:02 INFO - 'TMOUT': '86400', 03:02:02 INFO - 'USER': 'cltbld', 03:02:02 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:02 INFO - '_': '/tools/buildbot/bin/python'} 03:02:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:02 INFO - Running setup.py (path:/tmp/pip-iD_XS3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:02 INFO - Running setup.py (path:/tmp/pip-FgL2Pp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:02 INFO - Running setup.py (path:/tmp/pip-rV_3Qs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:02 INFO - Running setup.py (path:/tmp/pip-oEWlb2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:02 INFO - Running setup.py (path:/tmp/pip-NJ6FIw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:03 INFO - Running setup.py (path:/tmp/pip-11kODx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:03 INFO - Running setup.py (path:/tmp/pip-RkdFNB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:03 INFO - Running setup.py (path:/tmp/pip-JcAE28-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:03 INFO - Running setup.py (path:/tmp/pip-OZU3Ec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:03 INFO - Running setup.py (path:/tmp/pip-_ygrWD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:03 INFO - Running setup.py (path:/tmp/pip-TLB2m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:03 INFO - Running setup.py (path:/tmp/pip-ARYd5Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:03 INFO - Running setup.py (path:/tmp/pip-Vimmg1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:03 INFO - Running setup.py (path:/tmp/pip-Uutur7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:03 INFO - Running setup.py (path:/tmp/pip-NW9Daq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:03 INFO - Running setup.py (path:/tmp/pip-gsWecb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:03 INFO - Running setup.py (path:/tmp/pip-GMsQqH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:02:03 INFO - Running setup.py install for manifestparser 03:02:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for mozcrash 03:02:04 INFO - Running setup.py install for mozdebug 03:02:04 INFO - Running setup.py install for mozdevice 03:02:04 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for mozfile 03:02:04 INFO - Running setup.py install for mozhttpd 03:02:04 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for mozinfo 03:02:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for mozInstall 03:02:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for mozleak 03:02:04 INFO - Running setup.py install for mozlog 03:02:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:02:04 INFO - Running setup.py install for moznetwork 03:02:05 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Running setup.py install for mozprocess 03:02:05 INFO - Running setup.py install for mozprofile 03:02:05 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Running setup.py install for mozrunner 03:02:05 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Running setup.py install for mozscreenshot 03:02:05 INFO - Running setup.py install for moztest 03:02:05 INFO - Running setup.py install for mozversion 03:02:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:02:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:02:05 INFO - Cleaning up... 03:02:05 INFO - Return code: 0 03:02:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:02:05 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 03:02:05 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 03:02:05 INFO - Using env: {'DISPLAY': ':0', 03:02:05 INFO - 'HOME': '/home/cltbld', 03:02:05 INFO - 'LANG': 'en_US.UTF-8', 03:02:05 INFO - 'LANGUAGE': 'en_US:en', 03:02:05 INFO - 'LOGNAME': 'cltbld', 03:02:05 INFO - 'MAIL': '/var/mail/cltbld', 03:02:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:05 INFO - 'MOZ_NO_REMOTE': '1', 03:02:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:05 INFO - 'NO_EM_RESTART': '1', 03:02:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:05 INFO - 'PWD': '/builds/slave/test', 03:02:05 INFO - 'SHELL': '/bin/bash', 03:02:05 INFO - 'SHLVL': '1', 03:02:05 INFO - 'TERM': 'linux', 03:02:05 INFO - 'TMOUT': '86400', 03:02:05 INFO - 'USER': 'cltbld', 03:02:05 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:05 INFO - '_': '/tools/buildbot/bin/python'} 03:02:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:02:05 INFO - Running setup.py (path:/tmp/pip-MmPOQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:02:05 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:02:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:02:05 INFO - Running setup.py (path:/tmp/pip-vekhUX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:02:06 INFO - Running setup.py (path:/tmp/pip-RcJKD3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:02:06 INFO - Running setup.py (path:/tmp/pip-5oKuQm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:02:06 INFO - Running setup.py (path:/tmp/pip-_SI1cY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:02:06 INFO - Running setup.py (path:/tmp/pip-fd2yZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:02:06 INFO - Running setup.py (path:/tmp/pip-5r3A9o-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:02:06 INFO - Running setup.py (path:/tmp/pip-onLOk1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:02:06 INFO - Running setup.py (path:/tmp/pip-W7hhPy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:02:06 INFO - Running setup.py (path:/tmp/pip-1VOPmZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:02:06 INFO - Running setup.py (path:/tmp/pip-HD5rei-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:02:06 INFO - Running setup.py (path:/tmp/pip-SX2oGM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:02:06 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)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:02:06 INFO - Running setup.py (path:/tmp/pip-7YNAhm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:02:06 INFO - Running setup.py (path:/tmp/pip-_28abS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:02:06 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:02:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:06 INFO - Running setup.py (path:/tmp/pip-OFOnj4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:02:07 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)) 03:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:02:07 INFO - Running setup.py (path:/tmp/pip-bf4GCD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:02:07 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)) 03:02:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:02:07 INFO - Running setup.py (path:/tmp/pip-fZldJG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:02:07 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)) 03:02:07 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)) 03:02: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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:02:07 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)) 03:02:07 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)) 03:02:07 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)) 03:02:07 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:08 INFO - Downloading blessings-1.5.1.tar.gz 03:02:08 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:02:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:02:08 INFO - Installing collected packages: blessings 03:02:08 INFO - Running setup.py install for blessings 03:02:09 INFO - Successfully installed blessings 03:02:09 INFO - Cleaning up... 03:02:09 INFO - Return code: 0 03:02:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:02:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:09 INFO - Reading from file tmpfile_stdout 03:02:09 INFO - Current package versions: 03:02:09 INFO - argparse == 1.2.1 03:02:09 INFO - blessings == 1.5.1 03:02:09 INFO - blobuploader == 1.2.4 03:02:09 INFO - docopt == 0.6.1 03:02:09 INFO - manifestparser == 1.1 03:02:09 INFO - mozInstall == 1.12 03:02:09 INFO - mozcrash == 0.16 03:02:09 INFO - mozdebug == 0.1 03:02:09 INFO - mozdevice == 0.47 03:02:09 INFO - mozfile == 1.2 03:02:09 INFO - mozhttpd == 0.7 03:02:09 INFO - mozinfo == 0.9 03:02:09 INFO - mozleak == 0.1 03:02:09 INFO - mozlog == 3.1 03:02:09 INFO - moznetwork == 0.27 03:02:09 INFO - mozprocess == 0.22 03:02:09 INFO - mozprofile == 0.27 03:02:09 INFO - mozrunner == 6.11 03:02:09 INFO - mozscreenshot == 0.1 03:02:09 INFO - mozsystemmonitor == 0.0 03:02:09 INFO - moztest == 0.7 03:02:09 INFO - mozversion == 1.4 03:02:09 INFO - psutil == 3.1.1 03:02:09 INFO - requests == 1.2.3 03:02:09 INFO - wsgiref == 0.1.2 03:02:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', '-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 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:02:09 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 03:02:09 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 03:02:09 INFO - Using env: {'DISPLAY': ':0', 03:02:09 INFO - 'HOME': '/home/cltbld', 03:02:09 INFO - 'LANG': 'en_US.UTF-8', 03:02:09 INFO - 'LANGUAGE': 'en_US:en', 03:02:09 INFO - 'LOGNAME': 'cltbld', 03:02:09 INFO - 'MAIL': '/var/mail/cltbld', 03:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:09 INFO - 'MOZ_NO_REMOTE': '1', 03:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:09 INFO - 'NO_EM_RESTART': '1', 03:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:09 INFO - 'PWD': '/builds/slave/test', 03:02:09 INFO - 'SHELL': '/bin/bash', 03:02:09 INFO - 'SHLVL': '1', 03:02:09 INFO - 'TERM': 'linux', 03:02:09 INFO - 'TMOUT': '86400', 03:02:09 INFO - 'USER': 'cltbld', 03:02:09 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:09 INFO - '_': '/tools/buildbot/bin/python'} 03:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 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)) 03:02:09 INFO - Cleaning up... 03:02:09 INFO - Return code: 0 03:02:09 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:02: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')]} 03:02:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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')]} 03:02:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:02: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', 'jsonschema'] in /builds/slave/test/build 03:02: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 jsonschema 03:02:09 INFO - Using env: {'DISPLAY': ':0', 03:02:09 INFO - 'HOME': '/home/cltbld', 03:02:09 INFO - 'LANG': 'en_US.UTF-8', 03:02:09 INFO - 'LANGUAGE': 'en_US:en', 03:02:09 INFO - 'LOGNAME': 'cltbld', 03:02:09 INFO - 'MAIL': '/var/mail/cltbld', 03:02:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:09 INFO - 'MOZ_NO_REMOTE': '1', 03:02:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:09 INFO - 'NO_EM_RESTART': '1', 03:02:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:09 INFO - 'PWD': '/builds/slave/test', 03:02:09 INFO - 'SHELL': '/bin/bash', 03:02:09 INFO - 'SHLVL': '1', 03:02:09 INFO - 'TERM': 'linux', 03:02:09 INFO - 'TMOUT': '86400', 03:02:09 INFO - 'USER': 'cltbld', 03:02:09 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:09 INFO - '_': '/tools/buildbot/bin/python'} 03:02:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:09 INFO - Downloading/unpacking jsonschema 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:11 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:02:11 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 03:02:11 INFO - Downloading/unpacking functools32 (from jsonschema) 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02: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 03:02:11 INFO - Downloading functools32-3.2.3-2.tar.gz 03:02:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:02:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:02:11 INFO - warning: no files found matching '*.txt' 03:02:11 INFO - no previously-included directories found matching 'build' 03:02:11 INFO - no previously-included directories found matching 'dist' 03:02:11 INFO - no previously-included directories found matching '.git*' 03:02:11 INFO - Installing collected packages: jsonschema, functools32 03:02:11 INFO - Running setup.py install for functools32 03:02:11 INFO - warning: no files found matching '*.txt' 03:02:11 INFO - no previously-included directories found matching 'build' 03:02:11 INFO - no previously-included directories found matching 'dist' 03:02:11 INFO - no previously-included directories found matching '.git*' 03:02:11 INFO - Successfully installed jsonschema functools32 03:02:11 INFO - Cleaning up... 03:02:11 INFO - Return code: 0 03:02:11 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:02:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:02:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3941108f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x273e8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x280c240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, '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': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', '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 03:02:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:02:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:02:11 INFO - Using env: {'DISPLAY': ':0', 03:02:11 INFO - 'HOME': '/home/cltbld', 03:02:11 INFO - 'LANG': 'en_US.UTF-8', 03:02:11 INFO - 'LANGUAGE': 'en_US:en', 03:02:11 INFO - 'LOGNAME': 'cltbld', 03:02:11 INFO - 'MAIL': '/var/mail/cltbld', 03:02:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:11 INFO - 'MOZ_NO_REMOTE': '1', 03:02:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:11 INFO - 'NO_EM_RESTART': '1', 03:02:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:11 INFO - 'PWD': '/builds/slave/test', 03:02:11 INFO - 'SHELL': '/bin/bash', 03:02:11 INFO - 'SHLVL': '1', 03:02:11 INFO - 'TERM': 'linux', 03:02:11 INFO - 'TMOUT': '86400', 03:02:11 INFO - 'USER': 'cltbld', 03:02:11 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:11 INFO - '_': '/tools/buildbot/bin/python'} 03:02:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:02:12 INFO - Downloading/unpacking flake8 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:12 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 03:02:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:02:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:02:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:02:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:02:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:02:14 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:02:14 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 03:02:14 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 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 03:02:14 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:02:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:14 INFO - no previously-included directories found matching 'docs/_build' 03:02:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:02:14 INFO - Running setup.py install for pep8 03:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:02:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:02:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:02:14 INFO - no previously-included directories found matching 'docs/_build' 03:02:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:02:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:02:14 INFO - Cleaning up... 03:02:14 INFO - Return code: 0 03:02:14 INFO - Running post-action listener: _resource_record_post_action 03:02:14 INFO - Running post-action listener: _start_resource_monitoring 03:02:14 INFO - Starting resource monitoring. 03:02:14 INFO - ##### 03:02:14 INFO - ##### Running install step. 03:02:14 INFO - ##### 03:02:14 INFO - Running pre-action listener: _resource_record_pre_action 03:02:14 INFO - Running main action method: install 03:02:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:02:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:02:15 INFO - Reading from file tmpfile_stdout 03:02:15 INFO - Detecting whether we're running mozinstall >=1.0... 03:02:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:02:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:02:15 INFO - Reading from file tmpfile_stdout 03:02:15 INFO - Output received: 03:02:15 INFO - Usage: mozinstall [options] installer 03:02:15 INFO - Options: 03:02:15 INFO - -h, --help show this help message and exit 03:02:15 INFO - -d DEST, --destination=DEST 03:02:15 INFO - Directory to install application into. [default: 03:02:15 INFO - "/builds/slave/test"] 03:02:15 INFO - --app=APP Application being installed. [default: firefox] 03:02:15 INFO - mkdir: /builds/slave/test/build/application 03:02:15 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'] 03:02:15 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 03:02:29 INFO - Reading from file tmpfile_stdout 03:02:29 INFO - Output received: 03:02:29 INFO - /builds/slave/test/build/application/firefox/firefox 03:02:29 INFO - Running post-action listener: _resource_record_post_action 03:02:29 INFO - ##### 03:02:29 INFO - ##### Running run-tests step. 03:02:29 INFO - ##### 03:02:29 INFO - Running pre-action listener: _resource_record_pre_action 03:02:29 INFO - Running main action method: run_tests 03:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:02:29 INFO - Python 2.7.3 03:02:29 INFO - Return code: 0 03:02:29 INFO - grabbing minidump binary from tooltool 03:02:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:02:29 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x289b0b0>, '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 0x289bfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x289c440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:02:29 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:02:29 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:02:29 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:02:29 INFO - Return code: 0 03:02:29 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:02:29 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:02:29 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:02:29 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:02:29 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:02:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:02:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:02:30 INFO - Return code: 0 03:02:30 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/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] in /builds/slave/test/build 03:02:30 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/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-019 --webServer localhost 03:02:30 INFO - Using env: {'DISPLAY': ':0', 03:02:30 INFO - 'HOME': '/home/cltbld', 03:02:30 INFO - 'LANG': 'en_US.UTF-8', 03:02:30 INFO - 'LANGUAGE': 'en_US:en', 03:02:30 INFO - 'LOGNAME': 'cltbld', 03:02:30 INFO - 'MAIL': '/var/mail/cltbld', 03:02:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:02:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:02:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:02:30 INFO - 'MOZ_NO_REMOTE': '1', 03:02:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:02:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:02:30 INFO - 'NO_EM_RESTART': '1', 03:02:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:02:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:02:30 INFO - 'PWD': '/builds/slave/test', 03:02:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:02:30 INFO - 'SHELL': '/bin/bash', 03:02:30 INFO - 'SHLVL': '1', 03:02:30 INFO - 'TERM': 'linux', 03:02:30 INFO - 'TMOUT': '86400', 03:02:30 INFO - 'USER': 'cltbld', 03:02:30 INFO - 'XDG_SESSION_COOKIE': 'd60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409', 03:02:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:02:30 INFO - '_': '/tools/buildbot/bin/python'} 03:02:30 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/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-019', '--webServer', 'localhost'] with output_timeout 3600 03:02:30 INFO - mozversion INFO | application_buildid: 20151217022032 03:02:30 INFO - mozversion INFO | application_changeset: 1e4c936c142d5d13da442e8a82d4f30a40971153 03:02:30 INFO - mozversion INFO | application_display_name: Nightly 03:02:30 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:02:30 INFO - mozversion INFO | application_name: Firefox 03:02:30 INFO - mozversion INFO | application_remotingname: firefox 03:02:30 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 03:02:30 INFO - mozversion INFO | application_vendor: Mozilla 03:02:30 INFO - mozversion INFO | application_version: 46.0a1 03:02:30 INFO - mozversion INFO | platform_buildid: 20151217022032 03:02:30 INFO - mozversion INFO | platform_changeset: 1e4c936c142d5d13da442e8a82d4f30a40971153 03:02:30 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 03:02:30 INFO - mozversion INFO | platform_version: 46.0a1 03:02:30 INFO - 2015-12-17 03:02:30,859 DEBUG : using testdate: 1450350150 03:02:30 INFO - 2015-12-17 03:02:30,859 DEBUG : actual date: 1450350150 03:02:30 INFO - 2015-12-17 03:02:30,946 INFO : starting webserver on 'localhost:49873' 03:02:30 INFO - 2015-12-17 03:02:30,947 INFO : Starting test suite talos-linux64-ix-019 03:02:30 INFO - 2015-12-17 03:02:30,947 INFO : Starting test dromaeo_css 03:02:30 INFO - 2015-12-17 03:02:30,947 DEBUG : operating with platform_type : linux_ 03:02:30 INFO - 2015-12-17 03:02:30,948 INFO : Initialising browser for dromaeo_css test... 03:02:30 INFO - 2015-12-17 03:02:30,965 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWBMxy/profile http://localhost:49873/getInfo.html 03:02:35 INFO - 2015-12-17 03:02:35,121 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:02:35 INFO - 2015-12-17 03:02:35,121 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:02:35 INFO - 2015-12-17 03:02:35,121 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:02:35 INFO - 2015-12-17 03:02:35,121 DEBUG : BROWSER_OUTPUT: __metrics 03:02:35 INFO - 2015-12-17 03:02:35,218 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] 03:02:35 INFO - 2015-12-17 03:02:35,286 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] 03:02:36 INFO - 2015-12-17 03:02:36,585 INFO : Browser initialized. 03:02:36 INFO - 2015-12-17 03:02:36,585 INFO : Running cycle 1/1 for dromaeo_css test... 03:02:36 INFO - 2015-12-17 03:02:36,586 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAWBMxy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:02:48 INFO - 2015-12-17 03:02:48,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 03:02:48 INFO - 2015-12-17 03:02:48,587 DEBUG : BROWSER_OUTPUT: 03:03:39 INFO - 2015-12-17 03:03:39,843 DEBUG : BROWSER_OUTPUT: 1450350219842 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] 03:05:51 INFO - 2015-12-17 03:05:51,836 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49873/tests/dromaeo/cssquery-ext.html) 03:05:52 INFO - 2015-12-17 03:05:52,988 DEBUG : BROWSER_OUTPUT: RSS: Main: 243429376 03:05:52 INFO - 2015-12-17 03:05:52,988 DEBUG : BROWSER_OUTPUT: 03:08:55 INFO - 2015-12-17 03:08:55,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-ext.html (next: http://localhost:49873/tests/dromaeo/cssquery-jquery.html) 03:08:56 INFO - 2015-12-17 03:08:56,108 DEBUG : BROWSER_OUTPUT: RSS: Main: 221655040 03:08:56 INFO - 2015-12-17 03:08:56,108 DEBUG : BROWSER_OUTPUT: 03:11:58 INFO - 2015-12-17 03:11:58,109 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49873/tests/dromaeo/cssquery-mootools.html) 03:11:58 INFO - 2015-12-17 03:11:58,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 222121984 03:11:58 INFO - 2015-12-17 03:11:58,683 DEBUG : BROWSER_OUTPUT: 03:15:00 INFO - 2015-12-17 03:15:00,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49873/tests/dromaeo/cssquery-prototype.html) 03:15:01 INFO - 2015-12-17 03:15:01,218 DEBUG : BROWSER_OUTPUT: RSS: Main: 204464128 03:15:01 INFO - 2015-12-17 03:15:01,218 DEBUG : BROWSER_OUTPUT: 03:18:03 INFO - 2015-12-17 03:18:03,813 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49873/tests/dromaeo/cssquery-yui.html) 03:18:04 INFO - 2015-12-17 03:18:04,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 184410112 03:18:04 INFO - 2015-12-17 03:18:04,394 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,066 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/dromaeo/cssquery-yui.html (next: http://localhost:49873/tests/dromaeo/cssquery-dojo.html) 03:21:07 INFO - 2015-12-17 03:21:07,310 DEBUG : BROWSER_OUTPUT: RSS: Main: 265736192 03:21:07 INFO - 2015-12-17 03:21:07,310 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,312 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:21:07 INFO - 2015-12-17 03:21:07,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:21:07 INFO - 2015-12-17 03:21:07,312 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:21:07 INFO - 2015-12-17 03:21:07,312 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:21:07 INFO - 2015-12-17 03:21:07,314 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2637.7098519162887;2715.8370497770147;2720.918372448826;2729.072115480736;2739.47949889521;4593;4699.201135806912;4736.218523943554;4738.549837765416;4754.976225118874;4682.742449165295;4699.224627936395;4743.312219728137;4745.406824146981;4760.143174228638;4301.720388174775;4356.259435895905;4379.5182529921685;4395.274779661368;4438.600525952664;4162.771047592381;4388.846390376338;4410.845620403286;4455.8552270801265;4505.594496495315;4266.104118135196;4285.507166675826;4346.239408103569;4365.956340436618;4395.230834603964;4334;4377.562243775597;4389.978050109729;4420.049689316812;4422.756748378838;4128.277551428488;4357.324614684729;4360.978195109036;4383.473983122014;4434.423524941737;4524.8416305429155;4620.214563524209;4703.905921881577;4733.95266047342;4758.3576217210575;5087.465816089294;5095.388553373582;5096.745162741885;5103.591712662978;5140.485951404829;4813.3983252093485;4935.80256789728;5112.130937740556;5117.82087626935;5128.666636668605;4541.704789188692;4587.610053145453;4606.216943119678;4612.953870461286;4645.837395691135;5203.765830537635;5206.76569554371;5207.661502002357;5209.088409528317;5256.632035757537;4708.128996135726;4824.276358546246;4985.950140498621;4991.750412479361;5026.271190677331;4990.525900039491;4991.750412479434;5068.41713202979;5076.18780995039;5113;5036.84889453317;5073.365829271341;5074.391073071255;5083.186690129562;5123.052235336475;5035.672681275705;5052.823151189691;5055.418626857959;5058.266551350033;5106.412762532282;4110.979445102816;4141.316682747313;4185.811638476276;4224.134052519226;4236.385724069993;3705.110773414361;3709.3879509880567;3710.9814450927574;3724.9068773280883;3760.811959402019;4434.7560884151035;4437.179121862401;4438;4453.576910193527;4467.932981005288;4874.122657921537;4987.875303117451;4990.6506544541535;5132.28148059272;5140.40885298188;4284.528701842794;4357.433533640607;4377.474703035656;4413.205622987893;4416.668749843775;4486.416765820488;4490.12442573695;4496.235639941217;4499.842505512292;4533.750643714561;4634.791434385528;4757.833475828329;4763.047390521979;4832;4842.539958703917;4974.825881094144;5053.67151135175;5056.064628043824;5078.08594453002;5094.363204599425;4841.1285968526;4857.732824694534;4859.222524396079;4862.7325497098;4902.803887844446;4835.105505481497;5014.7994080236385;5015.3730783652045;5023.723695196799;5066.949330506648;4955.8017679292425;4987.10232158215;5006.524380184022;5097.719625420637;5133.460986596354;4871.8294859681155;4873.074115918106;4884.8046078157895;4888.144574699484;4927.778249978688;4727.290906364073;4865.440474345354;4867.172580661225;4867.58625516835;4920.8769780755765;4639.744814035261;4694.6009589185305;4756.16767065769;4759.619230461485;4759.762011899322;4946.183879659816;4952.455229924777;4959.454460009324;4968.304437378698;4993.750312484434;4667.159911216014;4847.854564363075;4850.151223535938;4855.902881942271;4897.0450762101045 03:21:07 INFO - 2015-12-17 03:21:07,317 DEBUG : BROWSER_OUTPUT: |1;ext.html;561.9912257497796;569.2173261765073;575.105710619986;576.2163457697532;579.4321564866431;26972.865135674318;32659;33511.66488335116;33519.16202094949;33592.328153436916;39480.21039579207;39983.80008099956;40043;40089.198216035664;40108.19783604326;6866.176058872942;7000.229974702778;7903.644336004879;7987.800304992364;8027.678892844279;10013.148882344973;10296.794064118712;10298.588056477733;10305.948470257676;10308.38149711016;9927.205823534136;10017.899821001769;10018.448985305806;10022.949885250564;10026.849597256047;6884.827879303032;7015.333543313377;7064.540804847668;9971.351862128939;10113.747156321077;9825.803483930353;9967.950160249226;9978;9982.850257246148;9992.95003524985;36915.261694765955;37244.813775931216;37391;37392.43911341332;37441.625583744084;2986.9551956720666;2987.44732224537;3039.361734035855;3051.038922739352;3616.1140520572367;27168;27171.1848644541;27838.582421263698;30940.10787959756;31144.37711245785;3195.6964088411564;3210.0851257391764;3263.216827961296;3267.134209434502;3305.636379998198;201364;201753;201949;202767;203403;51604.74197628988;52365.47634523682;55563.72218138883;57520.42479575234;58115.418845811844;54723.45276547183;54785;54845;55312.17031744527;55330.446695533334;14448.422063117569;14667.579849324955;14676.339564719614;14684.412623495155;14689.559313220621;10622.46887655614;10705.518251678694;10732.356058636507;10734.624288149877;10879;19019.33432329862;19252.326168584033;19285;19343.4196974091;19356.90321548383;7583.127940286828;7793.922060779433;7919.802004949923;7948.761537153895;7978.760637180894;831.3266254334009;862.7109918177481;916.2532535983286;937.2595649437005;1038.2680210451613;26681.19956401311;26803.463930721275;26814;29984.850075749917;30719.692803072132;979.5934687104772;988.7182153086336;1010.6614284214724;1021.0402221911379;1081.588996181446;15240.923795381173;15268.465603703817;16087.115208663401;16293.837061629469;16510.587235318973;315057;317973;321551;321809;323370;49064.7546762271;49389.75305123451;49515.50484495181;49573.75213123911;49581;1204.801207800703;1205.6503613951857;1208.3414539076225;1220.7070303127186;1223.3944197622056;26955.326116846452;27788.583171252852;28568.57147142836;29105.7089429103;31377.529337059506;43402;43413.348799767395;43496;44065.559344406145;44096.33855492106;224140;227265;227650;230193;230272;34523.30953380968;35390;38064;41421.79289103656;43143.35284970791;38144.427833583075;38358;38688.80655596704;38826.2234755309;38955;32363.51454728134;32854.507182392765;32932.1766955828;33752.83123584367;34039.65960340464;32360.44035156084;32391.51412728858;33265.33469330648;33273.50089748704;33516.49725254074;32772;32803.34393312073;32995.83502082474;33264;33691.820786272365;29518.262043449085;30408.695913040585;30848.84475273271;30971.380572388876;31047.534286986163;23569.882150589136;23922.40193995164;23947.80260986909;23973.160939367037;24295.757042429348 03:21:07 INFO - 2015-12-17 03:21:07,319 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.2199696703647;337.7804427122371;340.41108881634773;343.510497541004;343.5362260947719;12368.814467782968;12823.551175708852;14809.851901480983;14916.105033697972;15583.454579089734;12721.554745583906;14698.265086745647;14859;15282;15323.616909577266;4005.5994400559857;4850.708957462546;5008.7996480140755;5014.448410674823;5103.311053007852;5033.54698077173;5080;5085.0592640361465;5086.771095300702;5092.083424983502;4911.607071434295;4942.15983282841;4952.158133117378;5045.596352291808;5067.037262920052;4900;4908.5336892995465;4922.0402021605805;4923.286123512089;4924.556789888909;4317.611414972636;4327.307630779092;4329.112531930947;4337.37108119321;4654.371659825948;10698.465076746132;11005.229633925628;11164.441777911072;11165.441727913652;11178.217524773268;1878.2111513164366;1891.990540047291;1893.9242430302772;1918.060150526246;1968.3406058970263;8885.555722213863;8970.192682658528;9086.318526110568;9090.090990900922;11466.770664586662;1716.6223430845193;1730.3078768492578;1733.774609300783;1739.199968014702;1742.3727458115068;53471.732641336544;56025.43974560243;57253;57748.42251577514;58914;9741.805163896683;9881.851772223423;9956.352837065568;9963.153131983863;10023.799524009479;10466.476676166314;10604.204684648683;11806.822897656542;12572.937135314265;12580.748385032248;6864.313568643196;6992.860142797217;7042.964785176041;7054.365107140382;7108.040414543971;6737.629430381376;6758.986152077227;6769.559978601474;6784.8303792404595;6823.488238382141;3973.8609148679657;4000.5199376075057;4006.0786019215743;4073.7148399612333;4191.601797829201;1657.411618875306;1695.7202061659934;1700.7363858601936;1728.317314660727;1742.884633600387;856.6616186606255;858.5750053723447;874.1651722605025;910.5356268303213;940.7695114696807;15448.38206471751;15811.36754529829;16074.517764467084;16324.510264692079;16428.917855410884;751.2187325181859;810.7973006748313;860.6772460327377;919.5126582911067;934.5327336331834;7720.112187098443;8173.358044023392;8654.826903461895;8768.866221116312;8850.114988501098;493241;498019;499590;504902;516574;36526.817365913;48271.034579308216;53629.1955620666;59825.401745982854;69564.65217673879;1036.9118624916816;1051.3796859852723;1052.9996503321875;1056.6407421476736;1067.3862529045985;14366.209858457467;14461.204633744825;14520.201388923711;14650.34073466718;14812.851871481578;32397.19007024843;33073.83463082669;33103.34483275875;33239.667603324626;33241.002769916944;39102.413463798635;39338.606613933494;40356;40361.39457908193;45954.770226148656;8542.231199192103;8801.779955500908;8870.955645221733;8891.199792018491;8920.643174272956;10362.637307694496;12179.695507612381;15727.528174154793;16129.274182662042;16184.67630647404;13633.250171240677;13846.10000349974;13866.098703584235;13943.30283485842;14009.248843894513;13116.737665246832;13243.602691919257;13257.602271931857;13339.19964802115;13683.726325473634;13830.792538111735;14027.438902443788;14258.500952466615;14291.64270893236;14374.496892608708;8749;8824.338174637056;8835.293176545989;8848.070952550148;9046.457212567268;13250.138740981805;13388.062835601415;13616.65958351049;13845.584632461043;13969.790453143414 03:21:07 INFO - 2015-12-17 03:21:07,320 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1424.4373472478378;1667.8248783877693;1711.5464401933489;1714.1086634949827;1752.3516298969382;6090.66501342426;7083.504154709172;7282.308180722823;7301.08736407949;7302.19675835659;7199.352058314751;7353.558786472815;7365.410767138629;7378.852422951538;7384.520006199593;1747.248683066281;1775.3697437409728;2087.3737878636425;2096.7274254346953;2136.295022642532;2068.513899233679;2073.7615174255;2074.6161960037443;2076.3459510254297;2076.584683063393;2030.4416285521527;2053.6816793397047;2072.98963505183;2072.994597620153;2075.885826279554;1985.2059176329583;1994.2820584589535;2055.9074841632164;2084.42678263478;2085.8331333493284;2096.60164568733;2111.3349294972036;2118.396257066744;2118.470382404399;2118.5868755592664;7216.242294559048;7227.096612923385;7248.818779530501;7251.456140789462;7256.4920455568135;4205.179989901971;4247.49030116388;4260.169266992938;4277.272863613162;4293.270144075484;2642.920712378632;2645.8147929644933;2722.823016503941;2729.5359788835945;2756.7656749176344;867.5835598912557;873.6112429968666;880.4981160738382;884.4648987362682;900.9864852027159;9760.609575616967;9793.608255669764;9795.755106122333;9805.31362804604;9822.165115965152;3916.2167566486246;3937.5668676445566;3978.4430179774276;3987.6610488108254;3989.3816458448987;8427.030891447439;8439.324854011664;8439.873401898976;8440.493570385797;8464.788380290542;4319.438472998553;4333.306670932636;4339.609435150852;4341.131773645284;4344.54382289855;3968.7817170055346;3969.6625786807867;3976.721629485908;3980.900477488086;3982.38273067675;3010.5785190073407;3050.80169788963;3123.1567476781597;3160.1783536280273;3468.7745296555645;1095.835624656308;1108.972275693098;1113.9053180479589;1143.7540928700369;1145.6563031090639;977.203579083045;1025.9794804104026;1140.5836869542557;1229.4037391864938;1232.445399570197;6518.804435866931;6664.266930637626;6665.333466653393;6667.733290668319;6672.165979252593;1039.667306461925;1048.9475526223657;1053.2732414633879;1056.0759335581367;1072.8980746829038;5313.203019547099;5372.140457526777;5373.973130134403;5376.892462150735;5380.811671591476;8418.116097809765;8460.98468183822;8665.653373865101;8692.565371731389;8702.39083264178;8555.187257210555;8572.914270857336;8577.485350878967;8592.269657079218;8593.570321483901;6532.216134063848;6628.304028077079;6689.899651505231;6691.59850408977;6755.695993680296;6845.212800528003;6856.040154378491;6896;6902.447804175755;6922.58464492132;7739.187385324685;7781.572013539309;7837.059552853466;7838.882416763639;7909.05091389037;7925.0886148093705;8049.114597394165;8140.185981401813;8154.510729356258;8172.141925098017;6458.935410646021;6527.67361631926;6545.476361891133;6547.869042619026;6573.441257493167;5784.21913041734;6131.785387511416;6425.293217745951;6554.2462616797775;6555.115059467102;6530.379613936669;6538.280789113099;6635.2037755469655;6674.032265321404;6684.097646817618;6248.531360148098;6366.204224471941;6400.295967443484;6414.61512309263;6491.902621460587;6540.738370465128;6597.736090556324;6606.669666516751;6607.471402287902;6609.405153536205;5930.525557955267;5962.9105563415715;5963.940360596339;5970.58205925581;5971.164037034731;6044.365341639241;6085.208922840003;6093.969530152321;6101.7559297627595;6108.633481991094 03:21:07 INFO - 2015-12-17 03:21:07,321 DEBUG : BROWSER_OUTPUT: |4;prototype.html;301.38517424454113;304.66639030261865;305.8088694565896;310.0589710229453;312.58270209270614;5295.046891559523;5305.363356397228;5372.38217604975;5384.973075134629;5398.703071331075;5244.606654500909;5279.868003299919;5280.023195708796;5285.2600635911;5285.762140703668;3919.0594257378166;4100.323446631302;4100.487439070116;4101.30277852765;4102.0360215349365;4021.2962731521866;4047.5952404759582;4167.354060120686;4175.185838761443;4193.475815523059;4125.463689720347;4136.689748268892;4136.875893723193;4147.4815648044;4148.605882441178;3890.4164375343644;3969.622885825871;3981.6615587675083;4147;4153.65006372927;3601.783892966404;3608;3634.0914771307175;3636.054625797285;3637.399829028207;5095.592352611782;5112.437631860493;5114.923276150861;5119.462456442095;5130.820421285274;4713.882152946169;4715.1512727709;4727.267273572567;4728.148933192024;4728.69263497875;5419.376771671269;5547.195656629807;5563.388027316992;5576.721163941827;5582.748776305036;3951.031997160714;3958.5051868516434;3959.089409435846;3961.227560625679;3963.564007959122;5761.193432919395;5850.941490585083;5861.3552509223955;5864.06175011996;5867.530597552186;4080.367543030835;4084.550699423061;4090.2433049885867;4090.3250963590676;4092.9590704093175;4063.22798668258;4148.128892932518;4153.6677065834665;4156.480439945007;4157.812898419518;4706.317583950308;4718.646101542398;4720.551547602972;4723.716577005391;4726.4166504221475;5578.888422231533;5588.133839254922;5591.077472217039;5592.245046918695;5595.328560572757;1455.7379671658991;1481.733288008169;1484.7921291019265;1485.1089346392077;1485.1460410264142;1004.7739258666887;1007.0936157458347;1015.8115005443501;1028.0798685176726;1031.4533297352416;4896.730679812573;4917.336159618406;4925.901481970341;4933.407991041098;4937.308776771255;5766.0197766379815;5766.3368712598585;5775.566832487496;5778.10439381888;5784.855378615568;4913.950860491421;4929;4931.950680493149;4932.580730637864;4933.629977751683;3047.6342838859478;3090.490069138612;3120.7659425543175;3121.7970831895855;3130.373925214966;5446.700431476307;5473.425290344457;5484.122540393518;5488.451154884559;5488.506034456918;5935.258092738408;5937.881242375129;5942.910856337158;5943.494802941712;5944.85137871548;5484.287042684506;5484.972575137179;5487.094629386186;5492.835214943558;5495.835124946258;5604.635698679573;5766.4233576642;5769.451902069297;5770.682612456188;5774.971125144348;5623.044082506066;5638.126090455986;5639.125935480007;5651.265335506358;5653.660780353192;5472.370677372153;5475.069238229431;5477.507024367826;5487.176923461513;5489;3989.6010398961034;4027.315356389362;4069.552349241522;4074.2869997750868;4075.65356944663;5765.769369225184;5774.653520788766;5778.94221057784;5779;5785.82642520725;5528.391876893458;5528.889422211614;5535.778568857361;5536.390996990408;5537.058700020925;5569.248151499496;5573.080441727069;5576.052071147834;5577.8047768327915;5578.219049333178;5322.787088516416;5430.212619170277;5437.34751829783;5440.537554307928;5441.5374693151525;5409.6213265071065;5562.527185189304;5573.5819813513335;5581.051221292309;5588.944110559005;5368.704721240213;5489.835304940858;5509.531689806251;5512.614117011771;5517 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: |5;yui.html;655.9114519539861;764.1785081037879;770.7225398856409;779.3180966654178;800.8958835351407;11809.645710628673;11918.821217681741;11971.580994665177;11993.700157496056;11997.820032699494;11573.074154067675;11714.472848721807;12635;12663.55677551286;12679.61961141165;641.8844607970564;823.217942954193;837.2381133168817;837.2673910328463;837.844998675244;636.0522820996728;800.9479383840031;817.6729308276707;819.0744458761591;820.4134044158426;856.3235044314983;870.0038455967945;872.5506364222431;873.2795443758893;873.4977388001893;666.4368608525812;674.5986138247735;822.321584692625;857.8498762716531;859.072202021818;620.3455354600894;624.1573875268397;624.1823211592828;625.2340882419;628.4783629587478;9957.80084398308;10037.749056273578;10076.49617519121;10090.899091009069;10093.192544596415;10674.092702120251;10697.732556686067;10830.566777328897;10970.232083754141;11622.476988535536;9222.723318300461;9318.86021709675;9436.575354109082;9457.243420526342;9598.040195980417;3246.4643333849885;3266.657001014883;3276.3447310537986;3279.311344617633;3284.573005509292;38069.809650951844;38393.808030959946;38515.61484385176;38689.226215475814;38711.225775484614;8908.101470158561;8948.776280593038;9002.729918102468;9192.356535042483;9250.67622633218;15590.610234744223;15608.453704120302;15637.452689155825;15640.139792311305;15659.765103523456;6009.849753756191;6180.721867515973;6215.968920155461;6239.563230573907;6280.7487700491465;3307.2724000719804;3421.0934102462866;3444.793312401264;3461.498082777983;3544;2489.9293303879504;2508.059477695864;2524.5960646296503;2529.215943057658;2529.7976161907004;455.4466323417064;457.03565476843835;466.20279322359147;467.58618622518634;467.70534563224953;541.6154530283543;600.6486205569703;601.1613798750718;603.4930658247093;607.3926073926074;7896.289333959971;7909.288164065261;7912.492231199502;7933.404994625311;7989.56057416836;602.7528713227556;604.2024527623495;608.9330173680892;622.7508996401476;625.377749139609;3671.8714844980295;3790.3935370340614;3819.1406933439753;3862.594427585063;3921.058945852975;44861.77569112199;45757.31364029542;45967.540324596994;46013.5398646016;46025.07949840985;40762.9809254771;41411.37882931758;41413.37879931804;41594;41689.79155104205;37508.81245593809;38186.61813381886;38239.235215295535;38490.23019539593;38556.42165367465;7544.735934242275;7602.50583712057;8236.958815205886;8307.750767476986;8560.443571167854;28343.574846377735;28619.14142575726;28785.42429151447;28990;29297.7070229295;36981.26037479182;37760.433593496666;38350;38392.23215535618;38523;10032.899671003197;10062;10097.495125243562;10134.746631334276;10170.288079834636;11305.321680699184;11349.856769211608;11478.88521114778;11481.770364592829;11538.826917596074;10472.162227021972;10851.945740271249;11141.610043648434;11320;11326.546938122383;10691.839622405514;10871.945640271748;11235.438228088726;11249.71875703114;11277.887221127683;10492.527836247235;10862.293950893483;10872.293300935415;11007.119430445386;11055.336679799238;9307.883054033558;9457.905420945703;9584.66453674118;9606.711798646053;9792.608295668093;9044.276457883221;9049.54752262371;9108.157507847642;9212.401193922373;9320.440773553337 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,882 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351267311__endTimestamp 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,323 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: Number of tests: 6 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4662.41 Median:4759.62 stddev:482.78 (10.1%) stddev-sans-first:457.39 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: Values: 2637.7 2715.8 2720.9 2729.1 2739.5 4593.0 4699.2 4736.2 4738.5 4755.0 4682.7 4699.2 4743.3 4745.4 4760.1 4301.7 4356.3 4379.5 4395.3 4438.6 4162.8 4388.8 4410.8 4455.9 4505.6 4266.1 4285.5 4346.2 4366.0 4395.2 4334.0 4377.6 4390.0 4420.0 4422.8 4128.3 4357.3 4361.0 4383.5 4434.4 4524.8 4620.2 4703.9 4734.0 4758.4 5087.5 5095.4 5096.7 5103.6 5140.5 4813.4 4935.8 5112.1 5117.8 5128.7 4541.7 4587.6 4606.2 4613.0 4645.8 5203.8 5206.8 5207.7 5209.1 5256.6 4708.1 4824.3 4986.0 4991.8 5026.3 4990.5 4991.8 5068.4 5076.2 5113.0 5036.8 5073.4 5074.4 5083.2 5123.1 5035.7 5052.8 5055.4 5058.3 5106.4 4111.0 4141.3 4185.8 4224.1 4236.4 3705.1 3709.4 3711.0 3724.9 3760.8 4434.8 4437.2 4438.0 4453.6 4467.9 4874.1 4987.9 4990.7 5132.3 5140.4 4284.5 4357.4 4377.5 4413.2 4416.7 4486.4 4490.1 4496.2 4499.8 4533.8 4634.8 4757.8 4763.0 4832.0 4842.5 4974.8 5053.7 5056.1 5078.1 5094.4 4841.1 4857.7 4859.2 4862.7 4902.8 4835.1 5014.8 5015.4 5023.7 5066.9 4955.8 4987.1 5006.5 5097.7 5133.5 4871.8 4873.1 4884.8 4888.1 4927.8 4727.3 4865.4 4867.2 4867.6 4920.9 4639.7 4694.6 4756.2 4759.6 4759.8 4946.2 4952.5 4959.5 4968.3 4993.8 4667.2 4847.9 4850.2 4855.9 4897.0 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,324 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41766.88 Median:17963.07 stddev:66552.64 (370.5%) stddev-sans-first:66667.42 03:21:07 INFO - 2015-12-17 03:21:07,325 DEBUG : BROWSER_OUTPUT: Values: 562.0 569.2 575.1 576.2 579.4 26972.9 32659.0 33511.7 33519.2 33592.3 39480.2 39983.8 40043.0 40089.2 40108.2 6866.2 7000.2 7903.6 7987.8 8027.7 10013.1 10296.8 10298.6 10305.9 10308.4 9927.2 10017.9 10018.4 10022.9 10026.8 6884.8 7015.3 7064.5 9971.4 10113.7 9825.8 9968.0 9978.0 9982.9 9993.0 36915.3 37244.8 37391.0 37392.4 37441.6 2987.0 2987.4 3039.4 3051.0 3616.1 27168.0 27171.2 27838.6 30940.1 31144.4 3195.7 3210.1 3263.2 3267.1 3305.6 201364.0 201753.0 201949.0 202767.0 203403.0 51604.7 52365.5 55563.7 57520.4 58115.4 54723.5 54785.0 54845.0 55312.2 55330.4 14448.4 14667.6 14676.3 14684.4 14689.6 10622.5 10705.5 10732.4 10734.6 10879.0 19019.3 19252.3 19285.0 19343.4 19356.9 7583.1 7793.9 7919.8 7948.8 7978.8 831.3 862.7 916.3 937.3 1038.3 26681.2 26803.5 26814.0 29984.9 30719.7 979.6 988.7 1010.7 1021.0 1081.6 15240.9 15268.5 16087.1 16293.8 16510.6 315057.0 317973.0 321551.0 321809.0 323370.0 49064.8 49389.8 49515.5 49573.8 49581.0 1204.8 1205.7 1208.3 1220.7 1223.4 26955.3 27788.6 28568.6 29105.7 31377.5 43402.0 43413.3 43496.0 44065.6 44096.3 224140.0 227265.0 227650.0 230193.0 230272.0 34523.3 35390.0 38064.0 41421.8 43143.4 38144.4 38358.0 38688.8 38826.2 38955.0 32363.5 32854.5 32932.2 33752.8 34039.7 32360.4 32391.5 33265.3 33273.5 33516.5 32772.0 32803.3 32995.8 33264.0 33691.8 29518.3 30408.7 30848.8 30971.4 31047.5 23569.9 23922.4 23947.8 23973.2 24295.8 03:21:07 INFO - 2015-12-17 03:21:07,326 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,326 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25936.77 Median:3987.19 stddev:81888.15 (2053.8%) stddev-sans-first:82095.30 03:21:07 INFO - 2015-12-17 03:21:07,326 DEBUG : BROWSER_OUTPUT: Values: 336.2 337.8 340.4 343.5 343.5 12368.8 12823.6 14809.9 14916.1 15583.5 12721.6 14698.3 14859.0 15282.0 15323.6 4005.6 4850.7 5008.8 5014.4 5103.3 5033.5 5080.0 5085.1 5086.8 5092.1 4911.6 4942.2 4952.2 5045.6 5067.0 4900.0 4908.5 4922.0 4923.3 4924.6 4317.6 4327.3 4329.1 4337.4 4654.4 10698.5 11005.2 11164.4 11165.4 11178.2 1878.2 1892.0 1893.9 1918.1 1968.3 8885.6 8970.2 9086.3 9090.1 11466.8 1716.6 1730.3 1733.8 1739.2 1742.4 53471.7 56025.4 57253.0 57748.4 58914.0 9741.8 9881.9 9956.4 9963.2 10023.8 10466.5 10604.2 11806.8 12572.9 12580.7 6864.3 6992.9 7043.0 7054.4 7108.0 6737.6 6759.0 6769.6 6784.8 6823.5 3973.9 4000.5 4006.1 4073.7 4191.6 1657.4 1695.7 1700.7 1728.3 1742.9 856.7 858.6 874.2 910.5 940.8 15448.4 15811.4 16074.5 16324.5 16428.9 751.2 810.8 860.7 919.5 934.5 7720.1 8173.4 8654.8 8768.9 8850.1 493241.0 498019.0 499590.0 504902.0 516574.0 36526.8 48271.0 53629.2 59825.4 69564.7 1036.9 1051.4 1053.0 1056.6 1067.4 14366.2 14461.2 14520.2 14650.3 14812.9 32397.2 33073.8 33103.3 33239.7 33241.0 39102.4 39338.6 40356.0 40361.4 45954.8 8542.2 8801.8 8871.0 8891.2 8920.6 10362.6 12179.7 15727.5 16129.3 16184.7 13633.3 13846.1 13866.1 13943.3 14009.2 13116.7 13243.6 13257.6 13339.2 13683.7 13830.8 14027.4 14258.5 14291.6 14374.5 8749.0 8824.3 8835.3 8848.1 9046.5 13250.1 13388.1 13616.7 13845.6 13969.8 03:21:07 INFO - 2015-12-17 03:21:07,326 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,326 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5038.48 Median:6120.21 stddev:2612.31 (42.7%) stddev-sans-first:2605.51 03:21:07 INFO - 2015-12-17 03:21:07,327 DEBUG : BROWSER_OUTPUT: Values: 1424.4 1667.8 1711.5 1714.1 1752.4 6090.7 7083.5 7282.3 7301.1 7302.2 7199.4 7353.6 7365.4 7378.9 7384.5 1747.2 1775.4 2087.4 2096.7 2136.3 2068.5 2073.8 2074.6 2076.3 2076.6 2030.4 2053.7 2073.0 2073.0 2075.9 1985.2 1994.3 2055.9 2084.4 2085.8 2096.6 2111.3 2118.4 2118.5 2118.6 7216.2 7227.1 7248.8 7251.5 7256.5 4205.2 4247.5 4260.2 4277.3 4293.3 2642.9 2645.8 2722.8 2729.5 2756.8 867.6 873.6 880.5 884.5 901.0 9760.6 9793.6 9795.8 9805.3 9822.2 3916.2 3937.6 3978.4 3987.7 3989.4 8427.0 8439.3 8439.9 8440.5 8464.8 4319.4 4333.3 4339.6 4341.1 4344.5 3968.8 3969.7 3976.7 3980.9 3982.4 3010.6 3050.8 3123.2 3160.2 3468.8 1095.8 1109.0 1113.9 1143.8 1145.7 977.2 1026.0 1140.6 1229.4 1232.4 6518.8 6664.3 6665.3 6667.7 6672.2 1039.7 1048.9 1053.3 1056.1 1072.9 5313.2 5372.1 5374.0 5376.9 5380.8 8418.1 8461.0 8665.7 8692.6 8702.4 8555.2 8572.9 8577.5 8592.3 8593.6 6532.2 6628.3 6689.9 6691.6 6755.7 6845.2 6856.0 6896.0 6902.4 6922.6 7739.2 7781.6 7837.1 7838.9 7909.1 7925.1 8049.1 8140.2 8154.5 8172.1 6458.9 6527.7 6545.5 6547.9 6573.4 5784.2 6131.8 6425.3 6554.2 6555.1 6530.4 6538.3 6635.2 6674.0 6684.1 6248.5 6366.2 6400.3 6414.6 6491.9 6540.7 6597.7 6606.7 6607.5 6609.4 5930.5 5962.9 5963.9 5970.6 5971.2 6044.4 6085.2 6094.0 6101.8 6108.6 03:21:07 INFO - 2015-12-17 03:21:07,327 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,328 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4638.15 Median:5262.24 stddev:1345.33 (25.6%) stddev-sans-first:1309.14 03:21:07 INFO - 2015-12-17 03:21:07,328 DEBUG : BROWSER_OUTPUT: Values: 301.4 304.7 305.8 310.1 312.6 5295.0 5305.4 5372.4 5385.0 5398.7 5244.6 5279.9 5280.0 5285.3 5285.8 3919.1 4100.3 4100.5 4101.3 4102.0 4021.3 4047.6 4167.4 4175.2 4193.5 4125.5 4136.7 4136.9 4147.5 4148.6 3890.4 3969.6 3981.7 4147.0 4153.7 3601.8 3608.0 3634.1 3636.1 3637.4 5095.6 5112.4 5114.9 5119.5 5130.8 4713.9 4715.2 4727.3 4728.1 4728.7 5419.4 5547.2 5563.4 5576.7 5582.7 3951.0 3958.5 3959.1 3961.2 3963.6 5761.2 5850.9 5861.4 5864.1 5867.5 4080.4 4084.6 4090.2 4090.3 4093.0 4063.2 4148.1 4153.7 4156.5 4157.8 4706.3 4718.6 4720.6 4723.7 4726.4 5578.9 5588.1 5591.1 5592.2 5595.3 1455.7 1481.7 1484.8 1485.1 1485.1 1004.8 1007.1 1015.8 1028.1 1031.5 4896.7 4917.3 4925.9 4933.4 4937.3 5766.0 5766.3 5775.6 5778.1 5784.9 4914.0 4929.0 4932.0 4932.6 4933.6 3047.6 3090.5 3120.8 3121.8 3130.4 5446.7 5473.4 5484.1 5488.5 5488.5 5935.3 5937.9 5942.9 5943.5 5944.9 5484.3 5485.0 5487.1 5492.8 5495.8 5604.6 5766.4 5769.5 5770.7 5775.0 5623.0 5638.1 5639.1 5651.3 5653.7 5472.4 5475.1 5477.5 5487.2 5489.0 3989.6 4027.3 4069.6 4074.3 4075.7 5765.8 5774.7 5778.9 5779.0 5785.8 5528.4 5528.9 5535.8 5536.4 5537.1 5569.2 5573.1 5576.1 5577.8 5578.2 5322.8 5430.2 5437.3 5440.5 5441.5 5409.6 5562.5 5573.6 5581.1 5588.9 5368.7 5489.8 5509.5 5512.6 5517.0 03:21:07 INFO - 2015-12-17 03:21:07,328 DEBUG : BROWSER_OUTPUT: 03:21:07 INFO - 2015-12-17 03:21:07,329 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11792.05 Median:41412.38 stddev:12863.24 (31.1%) stddev-sans-first:12872.14 03:21:07 INFO - 2015-12-17 03:21:07,329 DEBUG : BROWSER_OUTPUT: Values: 655.9 764.2 770.7 779.3 800.9 11809.6 11918.8 11971.6 11993.7 11997.8 11573.1 11714.5 12635.0 12663.6 12679.6 641.9 823.2 837.2 837.3 837.8 636.1 800.9 817.7 819.1 820.4 856.3 870.0 872.6 873.3 873.5 666.4 674.6 822.3 857.8 859.1 620.3 624.2 624.2 625.2 628.5 9957.8 10037.7 10076.5 10090.9 10093.2 10674.1 10697.7 10830.6 10970.2 11622.5 9222.7 9318.9 9436.6 9457.2 9598.0 3246.5 3266.7 3276.3 3279.3 3284.6 38069.8 38393.8 38515.6 38689.2 38711.2 8908.1 8948.8 9002.7 9192.4 9250.7 15590.6 15608.5 15637.5 15640.1 15659.8 6009.8 6180.7 6216.0 6239.6 6280.7 3307.3 3421.1 3444.8 3461.5 3544.0 2489.9 2508.1 2524.6 2529.2 2529.8 455.4 457.0 466.2 467.6 467.7 541.6 600.6 601.2 603.5 607.4 7896.3 7909.3 7912.5 7933.4 7989.6 602.8 604.2 608.9 622.8 625.4 3671.9 3790.4 3819.1 3862.6 3921.1 44861.8 45757.3 45967.5 46013.5 46025.1 40763.0 41411.4 41413.4 41594.0 41689.8 37508.8 38186.6 38239.2 38490.2 38556.4 7544.7 7602.5 8237.0 8307.8 8560.4 28343.6 28619.1 28785.4 28990.0 29297.7 36981.3 37760.4 38350.0 38392.2 38523.0 10032.9 10062.0 10097.5 10134.7 10170.3 11305.3 11349.9 11478.9 11481.8 11538.8 10472.2 10851.9 11141.6 11320.0 11326.5 10691.8 10871.9 11235.4 11249.7 11277.9 10492.5 10862.3 10872.3 11007.1 11055.3 9307.9 9457.9 9584.7 9606.7 9792.6 9044.3 9049.5 9108.2 9212.4 9320.4 03:21:07 INFO - 2015-12-17 03:21:07,329 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:21:07 INFO - 2015-12-17 03:21:07,329 DEBUG : BROWSER_OUTPUT: 03:21:08 INFO - 2015-12-17 03:21:08,113 INFO : Browser exited with error code: 0 03:21:08 INFO - 2015-12-17 03:21:08,132 INFO : Completed test dromaeo_css (00:18:37) 03:21:08 INFO - 2015-12-17 03:21:08,132 INFO : Starting test kraken 03:21:08 INFO - 2015-12-17 03:21:08,132 DEBUG : operating with platform_type : linux_ 03:21:08 INFO - 2015-12-17 03:21:08,132 INFO : Initialising browser for kraken test... 03:21:08 INFO - 2015-12-17 03:21:08,138 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMIRqNl/profile http://localhost:49873/getInfo.html 03:21:12 INFO - 2015-12-17 03:21:12,582 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:21:12 INFO - 2015-12-17 03:21:12,582 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:21:12 INFO - 2015-12-17 03:21:12,582 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:21:12 INFO - 2015-12-17 03:21:12,582 DEBUG : BROWSER_OUTPUT: __metrics 03:21:12 INFO - 2015-12-17 03:21:12,659 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] 03:21:12 INFO - 2015-12-17 03:21:12,720 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] 03:21:12 ERROR - 2015-12-17 03:21:12,736 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:21:13 INFO - 2015-12-17 03:21:13,558 INFO : Browser initialized. 03:21:13 INFO - 2015-12-17 03:21:13,559 INFO : Running cycle 1/1 for kraken test... 03:21:13 INFO - 2015-12-17 03:21:13,559 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpMIRqNl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:21:25 INFO - 2015-12-17 03:21:25,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 142147584 03:21:25 INFO - 2015-12-17 03:21:25,589 DEBUG : BROWSER_OUTPUT: 03:21:28 INFO - 2015-12-17 03:21:28,227 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49873/tests/kraken/driver.html?testName=audio-beat-detection) 03:21:28 INFO - 2015-12-17 03:21:28,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 178425856 03:21:28 INFO - 2015-12-17 03:21:28,810 DEBUG : BROWSER_OUTPUT: 03:21:31 INFO - 2015-12-17 03:21:31,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49873/tests/kraken/driver.html?testName=audio-dft) 03:21:32 INFO - 2015-12-17 03:21:32,113 DEBUG : BROWSER_OUTPUT: RSS: Main: 169123840 03:21:32 INFO - 2015-12-17 03:21:32,113 DEBUG : BROWSER_OUTPUT: 03:21:35 INFO - 2015-12-17 03:21:35,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49873/tests/kraken/driver.html?testName=audio-fft) 03:21:35 INFO - 2015-12-17 03:21:35,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 153645056 03:21:35 INFO - 2015-12-17 03:21:35,694 DEBUG : BROWSER_OUTPUT: 03:21:37 INFO - 2015-12-17 03:21:37,746 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49873/tests/kraken/driver.html?testName=audio-oscillator) 03:21:38 INFO - 2015-12-17 03:21:38,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 155193344 03:21:38 INFO - 2015-12-17 03:21:38,314 DEBUG : BROWSER_OUTPUT: 03:21:40 INFO - 2015-12-17 03:21:40,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49873/tests/kraken/driver.html?testName=imaging-gaussian-blur) 03:21:41 INFO - 2015-12-17 03:21:41,131 DEBUG : BROWSER_OUTPUT: RSS: Main: 158257152 03:21:41 INFO - 2015-12-17 03:21:41,131 DEBUG : BROWSER_OUTPUT: 03:21:44 INFO - 2015-12-17 03:21:44,150 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49873/tests/kraken/driver.html?testName=imaging-darkroom) 03:21:44 INFO - 2015-12-17 03:21:44,723 DEBUG : BROWSER_OUTPUT: RSS: Main: 158744576 03:21:44 INFO - 2015-12-17 03:21:44,724 DEBUG : BROWSER_OUTPUT: 03:21:48 INFO - 2015-12-17 03:21:48,147 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49873/tests/kraken/driver.html?testName=imaging-desaturate) 03:21:48 INFO - 2015-12-17 03:21:48,720 DEBUG : BROWSER_OUTPUT: RSS: Main: 158273536 03:21:48 INFO - 2015-12-17 03:21:48,720 DEBUG : BROWSER_OUTPUT: 03:21:51 INFO - 2015-12-17 03:21:51,549 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49873/tests/kraken/driver.html?testName=json-parse-financial) 03:21:52 INFO - 2015-12-17 03:21:52,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 157761536 03:21:52 INFO - 2015-12-17 03:21:52,130 DEBUG : BROWSER_OUTPUT: 03:21:53 INFO - 2015-12-17 03:21:53,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49873/tests/kraken/driver.html?testName=json-stringify-tinderbox) 03:21:54 INFO - 2015-12-17 03:21:54,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 166768640 03:21:54 INFO - 2015-12-17 03:21:54,479 DEBUG : BROWSER_OUTPUT: 03:21:56 INFO - 2015-12-17 03:21:56,355 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-aes) 03:21:56 INFO - 2015-12-17 03:21:56,957 DEBUG : BROWSER_OUTPUT: RSS: Main: 166940672 03:21:56 INFO - 2015-12-17 03:21:56,957 DEBUG : BROWSER_OUTPUT: 03:21:59 INFO - 2015-12-17 03:21:59,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-ccm) 03:21:59 INFO - 2015-12-17 03:21:59,675 DEBUG : BROWSER_OUTPUT: RSS: Main: 176381952 03:21:59 INFO - 2015-12-17 03:21:59,675 DEBUG : BROWSER_OUTPUT: 03:22:02 INFO - 2015-12-17 03:22:02,196 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 03:22:02 INFO - 2015-12-17 03:22:02,782 DEBUG : BROWSER_OUTPUT: RSS: Main: 182824960 03:22:02 INFO - 2015-12-17 03:22:02,782 DEBUG : BROWSER_OUTPUT: 03:22:05 INFO - 2015-12-17 03:22:05,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 03:22:05 INFO - 2015-12-17 03:22:05,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 179634176 03:22:05 INFO - 2015-12-17 03:22:05,972 DEBUG : BROWSER_OUTPUT: 03:22:07 INFO - 2015-12-17 03:22:07,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49873/tests/kraken/driver.html?testName=ai-astar) 03:22:07 INFO - 2015-12-17 03:22:07,992 DEBUG : BROWSER_OUTPUT: RSS: Main: 237613056 03:22:07 INFO - 2015-12-17 03:22:07,992 DEBUG : BROWSER_OUTPUT: 03:22:07 INFO - 2015-12-17 03:22:07,994 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:22:07 INFO - 2015-12-17 03:22:07,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:22:07 INFO - 2015-12-17 03:22:07,994 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:22:07 INFO - 2015-12-17 03:22:07,995 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:22:07 INFO - 2015-12-17 03:22:07,995 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;116;109;116;114;115;103;114;113;121 03:22:07 INFO - 2015-12-17 03:22:07,995 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;133;156;170;130;151;153;143;173;132 03:22:07 INFO - 2015-12-17 03:22:07,995 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;162;162;162;163;162;162;164 03:22:07 INFO - 2015-12-17 03:22:07,996 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;73;90;94;75;72;72;98;87;72 03:22:07 INFO - 2015-12-17 03:22:07,996 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;145;95;96;95;133;95;96;127 03:22:07 INFO - 2015-12-17 03:22:07,996 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;109;110;109;109;110;110 03:22:07 INFO - 2015-12-17 03:22:07,997 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;147;147;146;146;146;147;147 03:22:08 INFO - 2015-12-17 03:22:07,997 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 03:22:08 INFO - 2015-12-17 03:22:07,997 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;72;73;72;74;73;82;72;73 03:22:08 INFO - 2015-12-17 03:22:07,997 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;70;69;68;69;68 03:22:08 INFO - 2015-12-17 03:22:07,998 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;85;85;85;92;85;85;84;86;84 03:22:08 INFO - 2015-12-17 03:22:07,998 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;119;120;116;125;134;128;128;123;128 03:22:08 INFO - 2015-12-17 03:22:07,998 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;146;146;139;143;144;146;136;147;136 03:22:08 INFO - 2015-12-17 03:22:07,998 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;70;70;73;70;68;68;69;69;72 03:22:08 INFO - 2015-12-17 03:22:07,999 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:22:08 INFO - 2015-12-17 03:22:07,999 DEBUG : BROWSER_OUTPUT: __start_cc_report 03:22:08 INFO - 2015-12-17 03:22:07,999 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 03:22:08 INFO - 2015-12-17 03:22:07,999 DEBUG : BROWSER_OUTPUT: __end_cc_report 03:22:08 INFO - 2015-12-17 03:22:08,000 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351327993__endTimestamp 03:22:08 INFO - 2015-12-17 03:22:08,000 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,003 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:22:08 INFO - 2015-12-17 03:22:08,003 DEBUG : BROWSER_OUTPUT: Number of tests: 14 03:22:08 INFO - 2015-12-17 03:22:08,004 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,004 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:113.20 Median:114.50 stddev:4.80 (4.2%) stddev-sans-first:5.03 03:22:08 INFO - 2015-12-17 03:22:08,004 DEBUG : BROWSER_OUTPUT: Values: 111.0 116.0 109.0 116.0 114.0 115.0 103.0 114.0 113.0 121.0 03:22:08 INFO - 2015-12-17 03:22:08,004 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.40 Median:153.00 stddev:15.06 (9.8%) stddev-sans-first:15.92 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: Values: 153.0 133.0 156.0 170.0 130.0 151.0 153.0 143.0 173.0 132.0 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:162.00 stddev:0.70 (0.4%) stddev-sans-first:0.71 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 162.0 162.0 162.0 163.0 162.0 162.0 164.0 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.80 Median:81.00 stddev:10.29 (12.7%) stddev-sans-first:10.70 03:22:08 INFO - 2015-12-17 03:22:08,005 DEBUG : BROWSER_OUTPUT: Values: 75.0 73.0 90.0 94.0 75.0 72.0 72.0 98.0 87.0 72.0 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:95.00 stddev:19.60 (20.6%) stddev-sans-first:20.36 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 145.0 95.0 96.0 95.0 133.0 95.0 96.0 127.0 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 109.0 110.0 109.0 109.0 110.0 110.0 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:0.63 (0.4%) stddev-sans-first:0.50 03:22:08 INFO - 2015-12-17 03:22:08,006 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 147.0 147.0 146.0 146.0 146.0 147.0 147.0 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.70 Median:73.00 stddev:2.98 (4.1%) stddev-sans-first:3.15 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 72.0 73.0 72.0 74.0 73.0 82.0 72.0 73.0 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.63 (0.9%) stddev-sans-first:0.60 03:22:08 INFO - 2015-12-17 03:22:08,007 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 70.0 69.0 68.0 69.0 68.0 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.70 Median:85.00 stddev:2.31 (2.7%) stddev-sans-first:2.45 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: Values: 86.0 85.0 85.0 85.0 92.0 85.0 85.0 84.0 86.0 84.0 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.30 Median:126.50 stddev:5.36 (4.2%) stddev-sans-first:5.61 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: Values: 122.0 119.0 120.0 116.0 125.0 134.0 128.0 128.0 123.0 128.0 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.80 Median:145.00 stddev:4.80 (3.3%) stddev-sans-first:4.42 03:22:08 INFO - 2015-12-17 03:22:08,008 DEBUG : BROWSER_OUTPUT: Values: 135.0 146.0 146.0 139.0 143.0 144.0 146.0 136.0 147.0 136.0 03:22:08 INFO - 2015-12-17 03:22:08,009 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,009 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.63 (2.3%) stddev-sans-first:1.69 03:22:08 INFO - 2015-12-17 03:22:08,009 DEBUG : BROWSER_OUTPUT: Values: 71.0 70.0 70.0 73.0 70.0 68.0 68.0 69.0 69.0 72.0 03:22:08 INFO - 2015-12-17 03:22:08,009 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:22:08 INFO - 2015-12-17 03:22:08,009 DEBUG : BROWSER_OUTPUT: 03:22:08 INFO - 2015-12-17 03:22:08,921 INFO : Browser exited with error code: 0 03:22:08 INFO - 2015-12-17 03:22:08,970 INFO : Completed test kraken (00:01:00) 03:22:08 INFO - 2015-12-17 03:22:08,970 INFO : Starting test v8_7 03:22:08 INFO - 2015-12-17 03:22:08,970 DEBUG : operating with platform_type : linux_ 03:22:08 INFO - 2015-12-17 03:22:08,971 INFO : Initialising browser for v8_7 test... 03:22:08 INFO - 2015-12-17 03:22:08,977 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyz6yBC/profile http://localhost:49873/getInfo.html 03:22:13 INFO - 2015-12-17 03:22:13,039 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:22:13 INFO - 2015-12-17 03:22:13,039 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:22:13 INFO - 2015-12-17 03:22:13,039 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:22:13 INFO - 2015-12-17 03:22:13,039 DEBUG : BROWSER_OUTPUT: __metrics 03:22:13 INFO - 2015-12-17 03:22:13,140 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] 03:22:13 INFO - 2015-12-17 03:22:13,196 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] 03:22:14 INFO - 2015-12-17 03:22:14,496 INFO : Browser initialized. 03:22:14 INFO - 2015-12-17 03:22:14,497 INFO : Running cycle 1/1 for v8_7 test... 03:22:14 INFO - 2015-12-17 03:22:14,498 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyz6yBC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:22:26 INFO - 2015-12-17 03:22:26,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 142159872 03:22:26 INFO - 2015-12-17 03:22:26,579 DEBUG : BROWSER_OUTPUT: 03:22:47 INFO - 2015-12-17 03:22:47,954 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49873/tests/v8_7/run.html (next: http://localhost:49873/tests/v8_7/run.html) 03:22:48 INFO - 2015-12-17 03:22:48,204 DEBUG : BROWSER_OUTPUT: RSS: Main: 447246336 03:22:48 INFO - 2015-12-17 03:22:48,204 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,205 DEBUG : BROWSER_OUTPUT: __start_tp_report 03:22:48 INFO - 2015-12-17 03:22:48,205 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |0;Richards;169.29067208396816 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.1850679575498 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.45229383619477 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 03:22:48 INFO - 2015-12-17 03:22:48,206 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2008.0321285140562 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: |7;RegExp;27540.54054054054 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: |8;Splay;615.3846153846154 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: __end_tp_report 03:22:48 INFO - 2015-12-17 03:22:48,207 DEBUG : BROWSER_OUTPUT: __startTimestamp1450351368204__endTimestamp 03:22:48 INFO - 2015-12-17 03:22:48,208 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,208 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 03:22:48 INFO - 2015-12-17 03:22:48,208 DEBUG : BROWSER_OUTPUT: Number of tests: 10 03:22:48 INFO - 2015-12-17 03:22:48,208 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,208 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:169.29 Median:169.29 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,210 DEBUG : BROWSER_OUTPUT: Values: 169.3 03:22:48 INFO - 2015-12-17 03:22:48,210 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,210 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.19 Median:186.19 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,210 DEBUG : BROWSER_OUTPUT: Values: 186.2 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.45 Median:281.45 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: Values: 281.5 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: Values: 5133.3 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,211 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2008.03 Median:2008.03 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: Values: 2008.0 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: Values: 791.8 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,212 DEBUG : BROWSER_OUTPUT: Values: 12219.5 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27540.54 Median:27540.54 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: Values: 27540.5 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.38 Median:615.38 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: Values: 615.4 03:22:48 INFO - 2015-12-17 03:22:48,213 DEBUG : BROWSER_OUTPUT: 03:22:48 INFO - 2015-12-17 03:22:48,214 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 03:22:48 INFO - 2015-12-17 03:22:48,214 DEBUG : BROWSER_OUTPUT: Values: 4830.9 03:22:48 INFO - 2015-12-17 03:22:48,214 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 03:22:48 INFO - 2015-12-17 03:22:48,214 DEBUG : BROWSER_OUTPUT: 03:22:49 INFO - 2015-12-17 03:22:49,133 INFO : Browser exited with error code: 0 03:22:49 INFO - 2015-12-17 03:22:49,148 INFO : Completed test v8_7 (00:00:40) 03:22:49 INFO - 2015-12-17 03:22:49,264 INFO : Completed test suite (00:20:18) 03:22:49 INFO - 2015-12-17 03:22:49,264 DEBUG : Working with test: dromaeo_css 03:22:49 INFO - 2015-12-17 03:22:49,264 DEBUG : Generating results file: dromaeo_css 03:22:49 INFO - 2015-12-17 03:22:49,265 DEBUG : Working with test: kraken 03:22:49 INFO - 2015-12-17 03:22:49,266 DEBUG : Generating results file: kraken 03:22:49 INFO - 2015-12-17 03:22:49,266 INFO : javascript benchmark 03:22:49 INFO - 2015-12-17 03:22:49,266 DEBUG : Working with test: v8_7 03:22:49 INFO - 2015-12-17 03:22:49,266 DEBUG : Generating results file: v8_7 03:22:49 INFO - 2015-12-17 03:22:49,267 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:49 INFO - 2015-12-17 03:22:49,319 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 03:22:49 INFO - 2015-12-17 03:22:49,319 DEBUG : process_Request line: dromaeo_css 6328.53 graph.html#tests=[[72,132,35]] 03:22:49 INFO - 2015-12-17 03:22:49,319 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:49 INFO - 2015-12-17 03:22:49,350 DEBUG : process_Request line: kraken 1528.70 graph.html#tests=[[232,132,35]] 03:22:49 INFO - 2015-12-17 03:22:49,350 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 03:22:49 INFO - 2015-12-17 03:22:49,379 DEBUG : process_Request line: v8_7 19654.24 graph.html#tests=[[230,132,35]] 03:22:49 INFO - 2015-12-17 03:22:49,380 INFO : javascript benchmark 03:22:49 INFO - 2015-12-17 03:22:49,384 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2637.7098519162887, 2715.8370497770147, 2720.918372448826, 2729.072115480736, 2739.47949889521, 4593.0, 4699.201135806912, 4736.218523943554, 4738.549837765416, 4754.976225118874, 4682.742449165295, 4699.224627936395, 4743.312219728137, 4745.406824146981, 4760.143174228638, 4301.720388174775, 4356.259435895905, 4379.5182529921685, 4395.274779661368, 4438.600525952664, 4162.771047592381, 4388.846390376338, 4410.845620403286, 4455.8552270801265, 4505.594496495315, 4266.104118135196, 4285.507166675826, 4346.239408103569, 4365.956340436618, 4395.230834603964, 4334.0, 4377.562243775597, 4389.978050109729, 4420.049689316812, 4422.756748378838, 4128.277551428488, 4357.324614684729, 4360.978195109036, 4383.473983122014, 4434.423524941737, 4524.8416305429155, 4620.214563524209, 4703.905921881577, 4733.95266047342, 4758.3576217210575, 5087.465816089294, 5095.388553373582, 5096.745162741885, 5103.591712662978, 5140.485951404829, 4813.3983252093485, 4935.80256789728, 5112.130937740556, 5117.82087626935, 5128.666636668605, 4541.704789188692, 4587.610053145453, 4606.216943119678, 4612.953870461286, 4645.837395691135, 5203.765830537635, 5206.76569554371, 5207.661502002357, 5209.088409528317, 5256.632035757537, 4708.128996135726, 4824.276358546246, 4985.950140498621, 4991.750412479361, 5026.271190677331, 4990.525900039491, 4991.750412479434, 5068.41713202979, 5076.18780995039, 5113.0, 5036.84889453317, 5073.365829271341, 5074.391073071255, 5083.186690129562, 5123.052235336475, 5035.672681275705, 5052.823151189691, 5055.418626857959, 5058.266551350033, 5106.412762532282, 4110.979445102816, 4141.316682747313, 4185.811638476276, 4224.134052519226, 4236.385724069993, 3705.110773414361, 3709.3879509880567, 3710.9814450927574, 3724.9068773280883, 3760.811959402019, 4434.7560884151035, 4437.179121862401, 4438.0, 4453.576910193527, 4467.932981005288, 4874.122657921537, 4987.875303117451, 4990.6506544541535, 5132.28148059272, 5140.40885298188, 4284.528701842794, 4357.433533640607, 4377.474703035656, 4413.205622987893, 4416.668749843775, 4486.416765820488, 4490.12442573695, 4496.235639941217, 4499.842505512292, 4533.750643714561, 4634.791434385528, 4757.833475828329, 4763.047390521979, 4832.0, 4842.539958703917, 4974.825881094144, 5053.67151135175, 5056.064628043824, 5078.08594453002, 5094.363204599425, 4841.1285968526, 4857.732824694534, 4859.222524396079, 4862.7325497098, 4902.803887844446, 4835.105505481497, 5014.7994080236385, 5015.3730783652045, 5023.723695196799, 5066.949330506648, 4955.8017679292425, 4987.10232158215, 5006.524380184022, 5097.719625420637, 5133.460986596354, 4871.8294859681155, 4873.074115918106, 4884.8046078157895, 4888.144574699484, 4927.778249978688, 4727.290906364073, 4865.440474345354, 4867.172580661225, 4867.58625516835, 4920.8769780755765, 4639.744814035261, 4694.6009589185305, 4756.16767065769, 4759.619230461485, 4759.762011899322, 4946.183879659816, 4952.455229924777, 4959.454460009324, 4968.304437378698, 4993.750312484434, 4667.159911216014, 4847.854564363075, 4850.151223535938, 4855.902881942271, 4897.0450762101045], "unit": "score", "name": "dojo.html", "value": 4632.696971128192}, {"lowerIsBetter": false, "replicates": [561.9912257497796, 569.2173261765073, 575.105710619986, 576.2163457697532, 579.4321564866431, 26972.865135674318, 32659.0, 33511.66488335116, 33519.16202094949, 33592.328153436916, 39480.21039579207, 39983.80008099956, 40043.0, 40089.198216035664, 40108.19783604326, 6866.176058872942, 7000.229974702778, 7903.644336004879, 7987.800304992364, 8027.678892844279, 10013.148882344973, 10296.794064118712, 10298.588056477733, 10305.948470257676, 10308.38149711016, 9927.205823534136, 10017.899821001769, 10018.448985305806, 10022.949885250564, 10026.849597256047, 6884.827879303032, 7015.333543313377, 7064.540804847668, 9971.351862128939, 10113.747156321077, 9825.803483930353, 9967.950160249226, 9978.0, 9982.850257246148, 9992.95003524985, 36915.261694765955, 37244.813775931216, 37391.0, 37392.43911341332, 37441.625583744084, 2986.9551956720666, 2987.44732224537, 3039.361734035855, 3051.038922739352, 3616.1140520572367, 27168.0, 27171.1848644541, 27838.582421263698, 30940.10787959756, 31144.37711245785, 3195.6964088411564, 3210.0851257391764, 3263.216827961296, 3267.134209434502, 3305.636379998198, 201364.0, 201753.0, 201949.0, 202767.0, 203403.0, 51604.74197628988, 52365.47634523682, 55563.72218138883, 57520.42479575234, 58115.418845811844, 54723.45276547183, 54785.0, 54845.0, 55312.17031744527, 55330.446695533334, 14448.422063117569, 14667.579849324955, 14676.339564719614, 14684.412623495155, 14689.559313220621, 10622.46887655614, 10705.518251678694, 10732.356058636507, 10734.624288149877, 10879.0, 19019.33432329862, 19252.326168584033, 19285.0, 19343.4196974091, 19356.90321548383, 7583.127940286828, 7793.922060779433, 7919.802004949923, 7948.761537153895, 7978.760637180894, 831.3266254334009, 862.7109918177481, 916.2532535983286, 937.2595649437005, 1038.2680210451613, 26681.19956401311, 26803.463930721275, 26814.0, 29984.850075749917, 30719.692803072132, 979.5934687104772, 988.7182153086336, 1010.6614284214724, 1021.0402221911379, 1081.588996181446, 15240.923795381173, 15268.465603703817, 16087.115208663401, 16293.837061629469, 16510.587235318973, 315057.0, 317973.0, 321551.0, 321809.0, 323370.0, 49064.7546762271, 49389.75305123451, 49515.50484495181, 49573.75213123911, 49581.0, 1204.801207800703, 1205.6503613951857, 1208.3414539076225, 1220.7070303127186, 1223.3944197622056, 26955.326116846452, 27788.583171252852, 28568.57147142836, 29105.7089429103, 31377.529337059506, 43402.0, 43413.348799767395, 43496.0, 44065.559344406145, 44096.33855492106, 224140.0, 227265.0, 227650.0, 230193.0, 230272.0, 34523.30953380968, 35390.0, 38064.0, 41421.79289103656, 43143.35284970791, 38144.427833583075, 38358.0, 38688.80655596704, 38826.2234755309, 38955.0, 32363.51454728134, 32854.507182392765, 32932.1766955828, 33752.83123584367, 34039.65960340464, 32360.44035156084, 32391.51412728858, 33265.33469330648, 33273.50089748704, 33516.49725254074, 32772.0, 32803.34393312073, 32995.83502082474, 33264.0, 33691.820786272365, 29518.262043449085, 30408.695913040585, 30848.84475273271, 30971.380572388876, 31047.534286986163, 23569.882150589136, 23922.40193995164, 23947.80260986909, 23973.160939367037, 24295.757042429348], "unit": "score", "name": "ext.html", "value": 17585.301225695297}, {"lowerIsBetter": false, "replicates": [336.2199696703647, 337.7804427122371, 340.41108881634773, 343.510497541004, 343.5362260947719, 12368.814467782968, 12823.551175708852, 14809.851901480983, 14916.105033697972, 15583.454579089734, 12721.554745583906, 14698.265086745647, 14859.0, 15282.0, 15323.616909577266, 4005.5994400559857, 4850.708957462546, 5008.7996480140755, 5014.448410674823, 5103.311053007852, 5033.54698077173, 5080.0, 5085.0592640361465, 5086.771095300702, 5092.083424983502, 4911.607071434295, 4942.15983282841, 4952.158133117378, 5045.596352291808, 5067.037262920052, 4900.0, 4908.5336892995465, 4922.0402021605805, 4923.286123512089, 4924.556789888909, 4317.611414972636, 4327.307630779092, 4329.112531930947, 4337.37108119321, 4654.371659825948, 10698.465076746132, 11005.229633925628, 11164.441777911072, 11165.441727913652, 11178.217524773268, 1878.2111513164366, 1891.990540047291, 1893.9242430302772, 1918.060150526246, 1968.3406058970263, 8885.555722213863, 8970.192682658528, 9086.318526110568, 9090.090990900922, 11466.770664586662, 1716.6223430845193, 1730.3078768492578, 1733.774609300783, 1739.199968014702, 1742.3727458115068, 53471.732641336544, 56025.43974560243, 57253.0, 57748.42251577514, 58914.0, 9741.805163896683, 9881.851772223423, 9956.352837065568, 9963.153131983863, 10023.799524009479, 10466.476676166314, 10604.204684648683, 11806.822897656542, 12572.937135314265, 12580.748385032248, 6864.313568643196, 6992.860142797217, 7042.964785176041, 7054.365107140382, 7108.040414543971, 6737.629430381376, 6758.986152077227, 6769.559978601474, 6784.8303792404595, 6823.488238382141, 3973.8609148679657, 4000.5199376075057, 4006.0786019215743, 4073.7148399612333, 4191.601797829201, 1657.411618875306, 1695.7202061659934, 1700.7363858601936, 1728.317314660727, 1742.884633600387, 856.6616186606255, 858.5750053723447, 874.1651722605025, 910.5356268303213, 940.7695114696807, 15448.38206471751, 15811.36754529829, 16074.517764467084, 16324.510264692079, 16428.917855410884, 751.2187325181859, 810.7973006748313, 860.6772460327377, 919.5126582911067, 934.5327336331834, 7720.112187098443, 8173.358044023392, 8654.826903461895, 8768.866221116312, 8850.114988501098, 493241.0, 498019.0, 499590.0, 504902.0, 516574.0, 36526.817365913, 48271.034579308216, 53629.1955620666, 59825.401745982854, 69564.65217673879, 1036.9118624916816, 1051.3796859852723, 1052.9996503321875, 1056.6407421476736, 1067.3862529045985, 14366.209858457467, 14461.204633744825, 14520.201388923711, 14650.34073466718, 14812.851871481578, 32397.19007024843, 33073.83463082669, 33103.34483275875, 33239.667603324626, 33241.002769916944, 39102.413463798635, 39338.606613933494, 40356.0, 40361.39457908193, 45954.770226148656, 8542.231199192103, 8801.779955500908, 8870.955645221733, 8891.199792018491, 8920.643174272956, 10362.637307694496, 12179.695507612381, 15727.528174154793, 16129.274182662042, 16184.67630647404, 13633.250171240677, 13846.10000349974, 13866.098703584235, 13943.30283485842, 14009.248843894513, 13116.737665246832, 13243.602691919257, 13257.602271931857, 13339.19964802115, 13683.726325473634, 13830.792538111735, 14027.438902443788, 14258.500952466615, 14291.64270893236, 14374.496892608708, 8749.0, 8824.338174637056, 8835.293176545989, 8848.070952550148, 9046.457212567268, 13250.138740981805, 13388.062835601415, 13616.65958351049, 13845.584632461043, 13969.790453143414], "unit": "score", "name": "jquery.html", "value": 7988.396276125303}, {"lowerIsBetter": false, "replicates": [1424.4373472478378, 1667.8248783877693, 1711.5464401933489, 1714.1086634949827, 1752.3516298969382, 6090.66501342426, 7083.504154709172, 7282.308180722823, 7301.08736407949, 7302.19675835659, 7199.352058314751, 7353.558786472815, 7365.410767138629, 7378.852422951538, 7384.520006199593, 1747.248683066281, 1775.3697437409728, 2087.3737878636425, 2096.7274254346953, 2136.295022642532, 2068.513899233679, 2073.7615174255, 2074.6161960037443, 2076.3459510254297, 2076.584683063393, 2030.4416285521527, 2053.6816793397047, 2072.98963505183, 2072.994597620153, 2075.885826279554, 1985.2059176329583, 1994.2820584589535, 2055.9074841632164, 2084.42678263478, 2085.8331333493284, 2096.60164568733, 2111.3349294972036, 2118.396257066744, 2118.470382404399, 2118.5868755592664, 7216.242294559048, 7227.096612923385, 7248.818779530501, 7251.456140789462, 7256.4920455568135, 4205.179989901971, 4247.49030116388, 4260.169266992938, 4277.272863613162, 4293.270144075484, 2642.920712378632, 2645.8147929644933, 2722.823016503941, 2729.5359788835945, 2756.7656749176344, 867.5835598912557, 873.6112429968666, 880.4981160738382, 884.4648987362682, 900.9864852027159, 9760.609575616967, 9793.608255669764, 9795.755106122333, 9805.31362804604, 9822.165115965152, 3916.2167566486246, 3937.5668676445566, 3978.4430179774276, 3987.6610488108254, 3989.3816458448987, 8427.030891447439, 8439.324854011664, 8439.873401898976, 8440.493570385797, 8464.788380290542, 4319.438472998553, 4333.306670932636, 4339.609435150852, 4341.131773645284, 4344.54382289855, 3968.7817170055346, 3969.6625786807867, 3976.721629485908, 3980.900477488086, 3982.38273067675, 3010.5785190073407, 3050.80169788963, 3123.1567476781597, 3160.1783536280273, 3468.7745296555645, 1095.835624656308, 1108.972275693098, 1113.9053180479589, 1143.7540928700369, 1145.6563031090639, 977.203579083045, 1025.9794804104026, 1140.5836869542557, 1229.4037391864938, 1232.445399570197, 6518.804435866931, 6664.266930637626, 6665.333466653393, 6667.733290668319, 6672.165979252593, 1039.667306461925, 1048.9475526223657, 1053.2732414633879, 1056.0759335581367, 1072.8980746829038, 5313.203019547099, 5372.140457526777, 5373.973130134403, 5376.892462150735, 5380.811671591476, 8418.116097809765, 8460.98468183822, 8665.653373865101, 8692.565371731389, 8702.39083264178, 8555.187257210555, 8572.914270857336, 8577.485350878967, 8592.269657079218, 8593.570321483901, 6532.216134063848, 6628.304028077079, 6689.899651505231, 6691.59850408977, 6755.695993680296, 6845.212800528003, 6856.040154378491, 6896.0, 6902.447804175755, 6922.58464492132, 7739.187385324685, 7781.572013539309, 7837.059552853466, 7838.882416763639, 7909.05091389037, 7925.0886148093705, 8049.114597394165, 8140.185981401813, 8154.510729356258, 8172.141925098017, 6458.935410646021, 6527.67361631926, 6545.476361891133, 6547.869042619026, 6573.441257493167, 5784.21913041734, 6131.785387511416, 6425.293217745951, 6554.2462616797775, 6555.115059467102, 6530.379613936669, 6538.280789113099, 6635.2037755469655, 6674.032265321404, 6684.097646817618, 6248.531360148098, 6366.204224471941, 6400.295967443484, 6414.61512309263, 6491.902621460587, 6540.738370465128, 6597.736090556324, 6606.669666516751, 6607.471402287902, 6609.405153536205, 5930.525557955267, 5962.9105563415715, 5963.940360596339, 5970.58205925581, 5971.164037034731, 6044.365341639241, 6085.208922840003, 6093.969530152321, 6101.7559297627595, 6108.633481991094], "unit": "score", "name": "mootools.html", "value": 4144.603942196564}, {"lowerIsBetter": false, "replicates": [301.38517424454113, 304.66639030261865, 305.8088694565896, 310.0589710229453, 312.58270209270614, 5295.046891559523, 5305.363356397228, 5372.38217604975, 5384.973075134629, 5398.703071331075, 5244.606654500909, 5279.868003299919, 5280.023195708796, 5285.2600635911, 5285.762140703668, 3919.0594257378166, 4100.323446631302, 4100.487439070116, 4101.30277852765, 4102.0360215349365, 4021.2962731521866, 4047.5952404759582, 4167.354060120686, 4175.185838761443, 4193.475815523059, 4125.463689720347, 4136.689748268892, 4136.875893723193, 4147.4815648044, 4148.605882441178, 3890.4164375343644, 3969.622885825871, 3981.6615587675083, 4147.0, 4153.65006372927, 3601.783892966404, 3608.0, 3634.0914771307175, 3636.054625797285, 3637.399829028207, 5095.592352611782, 5112.437631860493, 5114.923276150861, 5119.462456442095, 5130.820421285274, 4713.882152946169, 4715.1512727709, 4727.267273572567, 4728.148933192024, 4728.69263497875, 5419.376771671269, 5547.195656629807, 5563.388027316992, 5576.721163941827, 5582.748776305036, 3951.031997160714, 3958.5051868516434, 3959.089409435846, 3961.227560625679, 3963.564007959122, 5761.193432919395, 5850.941490585083, 5861.3552509223955, 5864.06175011996, 5867.530597552186, 4080.367543030835, 4084.550699423061, 4090.2433049885867, 4090.3250963590676, 4092.9590704093175, 4063.22798668258, 4148.128892932518, 4153.6677065834665, 4156.480439945007, 4157.812898419518, 4706.317583950308, 4718.646101542398, 4720.551547602972, 4723.716577005391, 4726.4166504221475, 5578.888422231533, 5588.133839254922, 5591.077472217039, 5592.245046918695, 5595.328560572757, 1455.7379671658991, 1481.733288008169, 1484.7921291019265, 1485.1089346392077, 1485.1460410264142, 1004.7739258666887, 1007.0936157458347, 1015.8115005443501, 1028.0798685176726, 1031.4533297352416, 4896.730679812573, 4917.336159618406, 4925.901481970341, 4933.407991041098, 4937.308776771255, 5766.0197766379815, 5766.3368712598585, 5775.566832487496, 5778.10439381888, 5784.855378615568, 4913.950860491421, 4929.0, 4931.950680493149, 4932.580730637864, 4933.629977751683, 3047.6342838859478, 3090.490069138612, 3120.7659425543175, 3121.7970831895855, 3130.373925214966, 5446.700431476307, 5473.425290344457, 5484.122540393518, 5488.451154884559, 5488.506034456918, 5935.258092738408, 5937.881242375129, 5942.910856337158, 5943.494802941712, 5944.85137871548, 5484.287042684506, 5484.972575137179, 5487.094629386186, 5492.835214943558, 5495.835124946258, 5604.635698679573, 5766.4233576642, 5769.451902069297, 5770.682612456188, 5774.971125144348, 5623.044082506066, 5638.126090455986, 5639.125935480007, 5651.265335506358, 5653.660780353192, 5472.370677372153, 5475.069238229431, 5477.507024367826, 5487.176923461513, 5489.0, 3989.6010398961034, 4027.315356389362, 4069.552349241522, 4074.2869997750868, 4075.65356944663, 5765.769369225184, 5774.653520788766, 5778.94221057784, 5779.0, 5785.82642520725, 5528.391876893458, 5528.889422211614, 5535.778568857361, 5536.390996990408, 5537.058700020925, 5569.248151499496, 5573.080441727069, 5576.052071147834, 5577.8047768327915, 5578.219049333178, 5322.787088516416, 5430.212619170277, 5437.34751829783, 5440.537554307928, 5441.5374693151525, 5409.6213265071065, 5562.527185189304, 5573.5819813513335, 5581.051221292309, 5588.944110559005, 5368.704721240213, 5489.835304940858, 5509.531689806251, 5512.614117011771, 5517.0], "unit": "score", "name": "prototype.html", "value": 4209.969333283186}, {"lowerIsBetter": false, "replicates": [655.9114519539861, 764.1785081037879, 770.7225398856409, 779.3180966654178, 800.8958835351407, 11809.645710628673, 11918.821217681741, 11971.580994665177, 11993.700157496056, 11997.820032699494, 11573.074154067675, 11714.472848721807, 12635.0, 12663.55677551286, 12679.61961141165, 641.8844607970564, 823.217942954193, 837.2381133168817, 837.2673910328463, 837.844998675244, 636.0522820996728, 800.9479383840031, 817.6729308276707, 819.0744458761591, 820.4134044158426, 856.3235044314983, 870.0038455967945, 872.5506364222431, 873.2795443758893, 873.4977388001893, 666.4368608525812, 674.5986138247735, 822.321584692625, 857.8498762716531, 859.072202021818, 620.3455354600894, 624.1573875268397, 624.1823211592828, 625.2340882419, 628.4783629587478, 9957.80084398308, 10037.749056273578, 10076.49617519121, 10090.899091009069, 10093.192544596415, 10674.092702120251, 10697.732556686067, 10830.566777328897, 10970.232083754141, 11622.476988535536, 9222.723318300461, 9318.86021709675, 9436.575354109082, 9457.243420526342, 9598.040195980417, 3246.4643333849885, 3266.657001014883, 3276.3447310537986, 3279.311344617633, 3284.573005509292, 38069.809650951844, 38393.808030959946, 38515.61484385176, 38689.226215475814, 38711.225775484614, 8908.101470158561, 8948.776280593038, 9002.729918102468, 9192.356535042483, 9250.67622633218, 15590.610234744223, 15608.453704120302, 15637.452689155825, 15640.139792311305, 15659.765103523456, 6009.849753756191, 6180.721867515973, 6215.968920155461, 6239.563230573907, 6280.7487700491465, 3307.2724000719804, 3421.0934102462866, 3444.793312401264, 3461.498082777983, 3544.0, 2489.9293303879504, 2508.059477695864, 2524.5960646296503, 2529.215943057658, 2529.7976161907004, 455.4466323417064, 457.03565476843835, 466.20279322359147, 467.58618622518634, 467.70534563224953, 541.6154530283543, 600.6486205569703, 601.1613798750718, 603.4930658247093, 607.3926073926074, 7896.289333959971, 7909.288164065261, 7912.492231199502, 7933.404994625311, 7989.56057416836, 602.7528713227556, 604.2024527623495, 608.9330173680892, 622.7508996401476, 625.377749139609, 3671.8714844980295, 3790.3935370340614, 3819.1406933439753, 3862.594427585063, 3921.058945852975, 44861.77569112199, 45757.31364029542, 45967.540324596994, 46013.5398646016, 46025.07949840985, 40762.9809254771, 41411.37882931758, 41413.37879931804, 41594.0, 41689.79155104205, 37508.81245593809, 38186.61813381886, 38239.235215295535, 38490.23019539593, 38556.42165367465, 7544.735934242275, 7602.50583712057, 8236.958815205886, 8307.750767476986, 8560.443571167854, 28343.574846377735, 28619.14142575726, 28785.42429151447, 28990.0, 29297.7070229295, 36981.26037479182, 37760.433593496666, 38350.0, 38392.23215535618, 38523.0, 10032.899671003197, 10062.0, 10097.495125243562, 10134.746631334276, 10170.288079834636, 11305.321680699184, 11349.856769211608, 11478.88521114778, 11481.770364592829, 11538.826917596074, 10472.162227021972, 10851.945740271249, 11141.610043648434, 11320.0, 11326.546938122383, 10691.839622405514, 10871.945640271748, 11235.438228088726, 11249.71875703114, 11277.887221127683, 10492.527836247235, 10862.293950893483, 10872.293300935415, 11007.119430445386, 11055.336679799238, 9307.883054033558, 9457.905420945703, 9584.66453674118, 9606.711798646053, 9792.608295668093, 9044.276457883221, 9049.54752262371, 9108.157507847642, 9212.401193922373, 9320.440773553337], "unit": "score", "name": "yui.html", "value": 5656.75469145022}], "name": "dromaeo_css", "value": 6328.533216873005}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 116.0, 109.0, 116.0, 114.0, 115.0, 103.0, 114.0, 113.0, 121.0], "unit": "score", "name": "ai-astar", "value": 113.2}, {"lowerIsBetter": true, "replicates": [153.0, 133.0, 156.0, 170.0, 130.0, 151.0, 153.0, 143.0, 173.0, 132.0], "unit": "score", "name": "audio-beat-detection", "value": 149.4}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 162.0, 162.0, 162.0, 163.0, 162.0, 162.0, 164.0], "unit": "score", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 90.0, 94.0, 75.0, 72.0, 72.0, 98.0, 87.0, 72.0], "unit": "score", "name": "audio-fft", "value": 80.8}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 145.0, 95.0, 96.0, 95.0, 133.0, 95.0, 96.0, 127.0], "unit": "score", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0, 147.0, 147.0], "unit": "score", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "score", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 72.0, 73.0, 72.0, 74.0, 73.0, 82.0, 72.0, 73.0], "unit": "score", "name": "json-parse-financial", "value": 73.7}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 70.0, 69.0, 68.0, 69.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 92.0, 85.0, 85.0, 84.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 85.7}, {"lowerIsBetter": true, "replicates": [122.0, 119.0, 120.0, 116.0, 125.0, 134.0, 128.0, 128.0, 123.0, 128.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.3}, {"lowerIsBetter": true, "replicates": [135.0, 146.0, 146.0, 139.0, 143.0, 144.0, 146.0, 136.0, 147.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 141.8}, {"lowerIsBetter": true, "replicates": [71.0, 70.0, 70.0, 73.0, 70.0, 68.0, 68.0, 69.0, 69.0, 72.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1528.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [169.29067208396816], "unit": "score", "name": "Richards", "value": 208.5289139999999}, {"lowerIsBetter": false, "replicates": [186.1850679575498], "unit": "score", "name": "DeltaBlue", "value": 355.1197780000001}, {"lowerIsBetter": false, "replicates": [281.45229383619477], "unit": "score", "name": "Encrypt", "value": 945.7410929999998}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2008.0321285140562], "unit": "score", "name": "RayTrace", "value": 368.51452200000006}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [27540.54054054054], "unit": "score", "name": "RegExp", "value": 33.07796368989208}, {"lowerIsBetter": false, "replicates": [615.3846153846154], "unit": "score", "name": "Splay", "value": 132.42287499999998}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19654.24130803495}]} 03:22:49 INFO - RETURN: dromaeo_css: 6328.53 03:22:49 INFO - RETURN: kraken: 1528.70 03:22:49 INFO - RETURN: v8_7: 19654.24 03:22:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19654.24"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1528.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6328.53"}}} 03:22:49 INFO - Return code: 0 03:22:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 03:22:49 ERROR - # TBPL SUCCESS # 03:22:49 INFO - Running post-action listener: _resource_record_post_action 03:22:49 INFO - Running post-run listener: _resource_record_post_run 03:22:50 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 507285504; Read time: 4; Write time: 465964 03:22:50 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 229101568; Read time: 0; Write time: 282304 03:22:50 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 275582976; Read time: 4; Write time: 183580 03:22:50 INFO - Running post-run listener: _upload_blobber_files 03:22:50 INFO - Blob upload gear active. 03:22:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 03:22:50 INFO - Copying logs to upload dir... 03:22:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1273.968570 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 13 secs) (at 2015-12-17 03:22:50.294069) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:50.300780) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009909 build_url: 'https://queue.taskcluster.net/v1/task/1_zXqISXSyiItZR_-bz7OA/artifacts/public/build/firefox-46.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:50.358400) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:50.358764) ========= 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=d60a7c61e513c1f504d0d12f000001b4-1450348369.56752-741728409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004400 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-17 03:22:50.410345) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:22:50.410905) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-17 03:22:50.411472) ========= ========= Total master_lag: 0.47 =========