builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-010 starttime: 1449834324.52 results: success (0) buildid: 20151211023240 builduid: e66f4db348bc43348f6c71b4c6727bea revision: 5562d39c90da9eb2de1ab212098cd5f1af1a6066 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.522397) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.522853) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.523204) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006471 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.552697) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.553011) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.619168) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.619481) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004583 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.679705) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.680016) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.680396) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.680762) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-11 03:45:25-- 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% 223M=0s 2015-12-11 03:45:25 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.164159 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.863917) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.864637) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.016675 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.916174) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:24.916856) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5562d39c90da9eb2de1ab212098cd5f1af1a6066 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5562d39c90da9eb2de1ab212098cd5f1af1a6066 --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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-11 03:45:25,837 truncating revision to first 12 chars 2015-12-11 03:45:25,837 Setting DEBUG logging. 2015-12-11 03:45:25,837 attempt 1/10 2015-12-11 03:45:25,837 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5562d39c90da?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-11 03:45:26,108 unpacking tar archive at: mozilla-central-5562d39c90da/testing/mozharness/ program finished with exit code 0 elapsedTime=0.550313 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:25.483249) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:25.483581) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:25.501329) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:25.501620) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-11 03:45:25.502030) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-11 03:45:25.502378) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:45:26 INFO - MultiFileLogger online at 20151211 03:45:26 in /builds/slave/test 03:45:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 03:45:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:45:26 INFO - {'append_to_log': False, 03:45:26 INFO - 'base_work_dir': '/builds/slave/test', 03:45:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 03:45:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:45:26 INFO - 'branch': 'Firefox-Non-PGO', 03:45:26 INFO - 'buildbot_json_path': 'buildprops.json', 03:45:26 INFO - 'config_files': ('talos/linux_config.py',), 03:45:26 INFO - 'default_actions': ('clobber', 03:45:26 INFO - 'read-buildbot-config', 03:45:26 INFO - 'download-and-extract', 03:45:26 INFO - 'populate-webroot', 03:45:26 INFO - 'create-virtualenv', 03:45:26 INFO - 'install', 03:45:26 INFO - 'run-tests'), 03:45:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:45:26 INFO - 'download_minidump_stackwalk': True, 03:45:26 INFO - 'download_symbols': 'ondemand', 03:45:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:45:26 INFO - 'tooltool.py': '/tools/tooltool.py', 03:45:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:45:26 INFO - '/tools/misc-python/virtualenv.py')}, 03:45:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:45:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:45:26 INFO - 'installer_path': 'installer.exe', 03:45:26 INFO - 'log_level': 'info', 03:45:26 INFO - 'log_name': 'talos', 03:45:26 INFO - 'log_to_console': True, 03:45:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:45:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:45:26 INFO - 'opt_config_files': (), 03:45:26 INFO - 'pip_index': False, 03:45:26 INFO - 'sps_profile': False, 03:45:26 INFO - 'sps_profile_interval': 0, 03:45:26 INFO - 'suite': 'dromaeojs', 03:45:26 INFO - 'system_bits': '64', 03:45:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:45:26 INFO - 'title': 'talos-linux64-ix-010', 03:45:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:45:26 INFO - 'use_talos_json': True, 03:45:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:45:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:45:26 INFO - 'work_dir': 'build'} 03:45:26 INFO - ##### 03:45:26 INFO - ##### Running clobber step. 03:45:26 INFO - ##### 03:45:26 INFO - Running pre-action listener: _resource_record_pre_action 03:45:26 INFO - Running main action method: clobber 03:45:26 INFO - rmtree: /builds/slave/test/build 03:45:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:45:27 INFO - Running post-action listener: _resource_record_post_action 03:45:27 INFO - ##### 03:45:27 INFO - ##### Running read-buildbot-config step. 03:45:27 INFO - ##### 03:45:27 INFO - Running pre-action listener: _resource_record_pre_action 03:45:27 INFO - Running main action method: read_buildbot_config 03:45:27 INFO - Using buildbot properties: 03:45:27 INFO - { 03:45:27 INFO - "properties": { 03:45:27 INFO - "buildnumber": 237, 03:45:27 INFO - "product": "firefox", 03:45:27 INFO - "script_repo_revision": "production", 03:45:27 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 03:45:27 INFO - "repository": "", 03:45:27 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 03:45:27 INFO - "buildid": "20151211023240", 03:45:27 INFO - "slavename": "talos-linux64-ix-010", 03:45:27 INFO - "pgo_build": "False", 03:45:27 INFO - "basedir": "/builds/slave/test", 03:45:27 INFO - "project": "", 03:45:27 INFO - "platform": "ubuntu64_hw", 03:45:27 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 03:45:27 INFO - "slavebuilddir": "test", 03:45:27 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 03:45:27 INFO - "branch": "mozilla-central", 03:45:27 INFO - "repo_path": "mozilla-central", 03:45:27 INFO - "stage_platform": "linux64", 03:45:27 INFO - "builduid": "e66f4db348bc43348f6c71b4c6727bea", 03:45:27 INFO - "revision": "5562d39c90da9eb2de1ab212098cd5f1af1a6066" 03:45:27 INFO - }, 03:45:27 INFO - "sourcestamp": { 03:45:27 INFO - "repository": "", 03:45:27 INFO - "hasPatch": false, 03:45:27 INFO - "project": "", 03:45:27 INFO - "branch": "mozilla-central-linux64-talos", 03:45:27 INFO - "changes": [ 03:45:27 INFO - { 03:45:27 INFO - "category": null, 03:45:27 INFO - "files": [ 03:45:27 INFO - { 03:45:27 INFO - "url": null, 03:45:27 INFO - "name": "https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:45:27 INFO - } 03:45:27 INFO - ], 03:45:27 INFO - "repository": "", 03:45:27 INFO - "rev": "5562d39c90da9eb2de1ab212098cd5f1af1a6066", 03:45:27 INFO - "who": "cbook@mozilla.com", 03:45:27 INFO - "when": 1449834279, 03:45:27 INFO - "number": 7326627, 03:45:27 INFO - "comments": "Bumping manifests a=b2g-bump", 03:45:27 INFO - "project": "", 03:45:27 INFO - "at": "Fri 11 Dec 2015 03:44:39", 03:45:27 INFO - "branch": "mozilla-central-linux64-talos", 03:45:27 INFO - "revlink": "", 03:45:27 INFO - "properties": [ 03:45:27 INFO - [ 03:45:27 INFO - "buildid", 03:45:27 INFO - "20151211023240", 03:45:27 INFO - "Change" 03:45:27 INFO - ], 03:45:27 INFO - [ 03:45:27 INFO - "builduid", 03:45:27 INFO - "e66f4db348bc43348f6c71b4c6727bea", 03:45:27 INFO - "Change" 03:45:27 INFO - ], 03:45:27 INFO - [ 03:45:27 INFO - "pgo_build", 03:45:27 INFO - "False", 03:45:27 INFO - "Change" 03:45:27 INFO - ] 03:45:27 INFO - ], 03:45:27 INFO - "revision": "5562d39c90da9eb2de1ab212098cd5f1af1a6066" 03:45:27 INFO - } 03:45:27 INFO - ], 03:45:27 INFO - "revision": "5562d39c90da9eb2de1ab212098cd5f1af1a6066" 03:45:27 INFO - } 03:45:27 INFO - } 03:45:27 INFO - Found installer url https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:45:27 INFO - Running post-action listener: _resource_record_post_action 03:45:27 INFO - ##### 03:45:27 INFO - ##### Running download-and-extract step. 03:45:27 INFO - ##### 03:45:27 INFO - Running pre-action listener: _resource_record_pre_action 03:45:27 INFO - Running main action method: download_and_extract 03:45:27 INFO - mkdir: /builds/slave/test/build/tests 03:45:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:27 INFO - https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:45:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/test_packages.json 03:45:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/test_packages.json 03:45:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:45:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:45:35 INFO - Downloaded 1302 bytes. 03:45:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:45:35 INFO - Using the following test package requirements: 03:45:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:45:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:45:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'jsshell-linux-x86_64.zip'], 03:45:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:45:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:45:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:45:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:45:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:45:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:45:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:45:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:45:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:45:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:35 INFO - https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:45:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:45:37 INFO - Downloaded 21866764 bytes. 03:45:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:45:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:45:38 INFO - Return code: 0 03:45:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 03:45:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:38 INFO - https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:45:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 03:45:44 INFO - Downloaded 21866764 bytes. 03:45:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 03:45:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:45:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 03:45:46 INFO - Return code: 0 03:45:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:46 INFO - https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:45:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:45:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:45:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:45:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 03:45:48 INFO - Downloaded 11132038 bytes. 03:45:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 03:45:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:45:48 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 03:45:48 INFO - Return code: 0 03:45:48 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:45:48 INFO - https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:45:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:45:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:45:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:45:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 03:45:49 INFO - Downloaded 57727215 bytes. 03:45:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:45:49 INFO - mkdir: /builds/slave/test/properties 03:45:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:45:49 INFO - Writing to file /builds/slave/test/properties/build_url 03:45:49 INFO - Contents: 03:45:49 INFO - build_url:https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:45:49 INFO - Running post-action listener: _resource_record_post_action 03:45:49 INFO - Running post-action listener: set_extra_try_arguments 03:45:49 INFO - ##### 03:45:49 INFO - ##### Running populate-webroot step. 03:45:49 INFO - ##### 03:45:49 INFO - Running pre-action listener: _resource_record_pre_action 03:45:49 INFO - Running main action method: populate_webroot 03:45:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:45:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:45:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:45:49 INFO - '--tppagecycles', 03:45:49 INFO - '7'], 03:45:49 INFO - 'tests': ['tsvgm']}}, 03:45:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:45:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:45:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:45:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:45:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:45:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'tests': ['damp', 'tps']}, 03:45:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['damp', 'tps']}, 03:45:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:45:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:45:49 INFO - 'other': {'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'other_l64': {'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'other_nol64': {'tests': ['a11yr', 03:45:49 INFO - 'ts_paint', 03:45:49 INFO - 'tpaint', 03:45:49 INFO - 'sessionrestore', 03:45:49 INFO - 'sessionrestore_no_auto_restore']}, 03:45:49 INFO - 'svgr': {'tests': ['tsvgx', 03:45:49 INFO - 'tsvgr_opacity', 03:45:49 INFO - 'tart', 03:45:49 INFO - 'tscrollx', 03:45:49 INFO - 'cart']}, 03:45:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['tsvgx', 03:45:49 INFO - 'tsvgr_opacity', 03:45:49 INFO - 'tart', 03:45:49 INFO - 'tscrollx', 03:45:49 INFO - 'cart']}, 03:45:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'tests': ['tp5o']}, 03:45:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'talos_options': ['--e10s'], 03:45:49 INFO - 'tests': ['tp5o']}, 03:45:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'talos_options': ['--xperf_path', 03:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:49 INFO - 'tests': ['tp5n']}, 03:45:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:45:49 INFO - 'talos_options': ['--e10s', 03:45:49 INFO - '--xperf_path', 03:45:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:45:49 INFO - 'tests': ['tp5n']}}, 03:45:49 INFO - 'talos.zip': {'path': '', 03:45:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:45:49 INFO - Running post-action listener: _resource_record_post_action 03:45:49 INFO - ##### 03:45:49 INFO - ##### Running create-virtualenv step. 03:45:49 INFO - ##### 03:45:49 INFO - Running pre-action listener: _resource_record_pre_action 03:45:49 INFO - Running main action method: create_virtualenv 03:45:49 INFO - Creating virtualenv /builds/slave/test/build/venv 03:45:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 03:45:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:45:49 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:45:49 INFO - Using real prefix '/usr' 03:45:49 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:45:50 INFO - Installing distribute.............................................................................................................................................................................................done. 03:45:52 INFO - Installing pip.................done. 03:45:52 INFO - Return code: 0 03:45:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:45:52 INFO - Using env: {'DISPLAY': ':0', 03:45:52 INFO - 'HOME': '/home/cltbld', 03:45:52 INFO - 'LANG': 'en_US.UTF-8', 03:45:52 INFO - 'LANGUAGE': 'en_US:en', 03:45:52 INFO - 'LOGNAME': 'cltbld', 03:45:52 INFO - 'MAIL': '/var/mail/cltbld', 03:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:52 INFO - 'MOZ_NO_REMOTE': '1', 03:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:52 INFO - 'NO_EM_RESTART': '1', 03:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:52 INFO - 'PWD': '/builds/slave/test', 03:45:52 INFO - 'SHELL': '/bin/bash', 03:45:52 INFO - 'SHLVL': '1', 03:45:52 INFO - 'TERM': 'linux', 03:45:52 INFO - 'TMOUT': '86400', 03:45:52 INFO - 'USER': 'cltbld', 03:45:52 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:52 INFO - '_': '/tools/buildbot/bin/python'} 03:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:45:52 INFO - Cleaning up... 03:45:52 INFO - Return code: 0 03:45:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:45:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 03:45:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 03:45:52 INFO - Using env: {'DISPLAY': ':0', 03:45:52 INFO - 'HOME': '/home/cltbld', 03:45:52 INFO - 'LANG': 'en_US.UTF-8', 03:45:52 INFO - 'LANGUAGE': 'en_US:en', 03:45:52 INFO - 'LOGNAME': 'cltbld', 03:45:52 INFO - 'MAIL': '/var/mail/cltbld', 03:45:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:52 INFO - 'MOZ_NO_REMOTE': '1', 03:45:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:52 INFO - 'NO_EM_RESTART': '1', 03:45:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:52 INFO - 'PWD': '/builds/slave/test', 03:45:52 INFO - 'SHELL': '/bin/bash', 03:45:52 INFO - 'SHLVL': '1', 03:45:52 INFO - 'TERM': 'linux', 03:45:52 INFO - 'TMOUT': '86400', 03:45:52 INFO - 'USER': 'cltbld', 03:45:52 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:45:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:52 INFO - '_': '/tools/buildbot/bin/python'} 03:45:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:52 INFO - Downloading/unpacking psutil>=0.7.1 03:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:45:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:45:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:45:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:54 INFO - Installing collected packages: psutil 03:45:54 INFO - Running setup.py install for psutil 03:45:54 INFO - building 'psutil._psutil_linux' extension 03:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 03:45:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 03:45:54 INFO - building 'psutil._psutil_posix' extension 03:45:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 03:45:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 03:45:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:45:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:45:55 INFO - Successfully installed psutil 03:45:55 INFO - Cleaning up... 03:45:55 INFO - Return code: 0 03:45:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:45:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45:55 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 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:45:55 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:45:55 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:45:55 INFO - Using env: {'DISPLAY': ':0', 03:45:55 INFO - 'HOME': '/home/cltbld', 03:45:55 INFO - 'LANG': 'en_US.UTF-8', 03:45:55 INFO - 'LANGUAGE': 'en_US:en', 03:45:55 INFO - 'LOGNAME': 'cltbld', 03:45:55 INFO - 'MAIL': '/var/mail/cltbld', 03:45:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:55 INFO - 'MOZ_NO_REMOTE': '1', 03:45:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:55 INFO - 'NO_EM_RESTART': '1', 03:45:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:55 INFO - 'PWD': '/builds/slave/test', 03:45:55 INFO - 'SHELL': '/bin/bash', 03:45:55 INFO - 'SHLVL': '1', 03:45:55 INFO - 'TERM': 'linux', 03:45:55 INFO - 'TMOUT': '86400', 03:45:55 INFO - 'USER': 'cltbld', 03:45:55 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:45:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:55 INFO - '_': '/tools/buildbot/bin/python'} 03:45:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:45:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:45:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:45:56 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:45:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:45:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:45:57 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:45:57 INFO - Installing collected packages: mozsystemmonitor 03:45:57 INFO - Running setup.py install for mozsystemmonitor 03:45:57 INFO - Successfully installed mozsystemmonitor 03:45:57 INFO - Cleaning up... 03:45:57 INFO - Return code: 0 03:45:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:45: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:45:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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:45:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:45:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:45: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', '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 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:45: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:45: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 blobuploader==1.2.4 03:45:57 INFO - Using env: {'DISPLAY': ':0', 03:45:57 INFO - 'HOME': '/home/cltbld', 03:45:57 INFO - 'LANG': 'en_US.UTF-8', 03:45:57 INFO - 'LANGUAGE': 'en_US:en', 03:45:57 INFO - 'LOGNAME': 'cltbld', 03:45:57 INFO - 'MAIL': '/var/mail/cltbld', 03:45:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:45:57 INFO - 'MOZ_NO_REMOTE': '1', 03:45:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:45:57 INFO - 'NO_EM_RESTART': '1', 03:45:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:45:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:45:57 INFO - 'PWD': '/builds/slave/test', 03:45:57 INFO - 'SHELL': '/bin/bash', 03:45:57 INFO - 'SHLVL': '1', 03:45:57 INFO - 'TERM': 'linux', 03:45:57 INFO - 'TMOUT': '86400', 03:45:57 INFO - 'USER': 'cltbld', 03:45:57 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:45:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:45:57 INFO - '_': '/tools/buildbot/bin/python'} 03:45:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:45:57 INFO - Downloading/unpacking blobuploader==1.2.4 03:45: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:45: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:45: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:45: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:45: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:45: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:45:59 INFO - Downloading blobuploader-1.2.4.tar.gz 03:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:45:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:45: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:45: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:45: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:45: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:45: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:45: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:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:45:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:45: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:45: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:45: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:45: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:45: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:45: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:45:59 INFO - Downloading docopt-0.6.1.tar.gz 03:45:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:45:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:45:59 INFO - Installing collected packages: blobuploader, requests, docopt 03:45:59 INFO - Running setup.py install for blobuploader 03:45:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:45:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:45:59 INFO - Running setup.py install for requests 03:46:00 INFO - Running setup.py install for docopt 03:46:00 INFO - Successfully installed blobuploader requests docopt 03:46:00 INFO - Cleaning up... 03:46:00 INFO - Return code: 0 03:46:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:46:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:46:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:00 INFO - Using env: {'DISPLAY': ':0', 03:46:00 INFO - 'HOME': '/home/cltbld', 03:46:00 INFO - 'LANG': 'en_US.UTF-8', 03:46:00 INFO - 'LANGUAGE': 'en_US:en', 03:46:00 INFO - 'LOGNAME': 'cltbld', 03:46:00 INFO - 'MAIL': '/var/mail/cltbld', 03:46:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:00 INFO - 'MOZ_NO_REMOTE': '1', 03:46:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:00 INFO - 'NO_EM_RESTART': '1', 03:46:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:00 INFO - 'PWD': '/builds/slave/test', 03:46:00 INFO - 'SHELL': '/bin/bash', 03:46:00 INFO - 'SHLVL': '1', 03:46:00 INFO - 'TERM': 'linux', 03:46:00 INFO - 'TMOUT': '86400', 03:46:00 INFO - 'USER': 'cltbld', 03:46:00 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:00 INFO - '_': '/tools/buildbot/bin/python'} 03:46:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:00 INFO - Running setup.py (path:/tmp/pip-E_bUOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:00 INFO - Running setup.py (path:/tmp/pip-VNbGhN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:00 INFO - Running setup.py (path:/tmp/pip-PtJxN3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:00 INFO - Running setup.py (path:/tmp/pip-0Zgy2r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:00 INFO - Running setup.py (path:/tmp/pip-SN_1Rq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:01 INFO - Running setup.py (path:/tmp/pip-2DV3yy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:01 INFO - Running setup.py (path:/tmp/pip-UVZiC_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:01 INFO - Running setup.py (path:/tmp/pip-JZy7wZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:01 INFO - Running setup.py (path:/tmp/pip-jyI6zL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:01 INFO - Running setup.py (path:/tmp/pip-gLjylK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:01 INFO - Running setup.py (path:/tmp/pip-MHOwUH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:01 INFO - Running setup.py (path:/tmp/pip-gmhFvi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:01 INFO - Running setup.py (path:/tmp/pip-H4azZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:01 INFO - Running setup.py (path:/tmp/pip-8g0Ytj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:01 INFO - Running setup.py (path:/tmp/pip-4LJFNh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:01 INFO - Running setup.py (path:/tmp/pip-5BSy8j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:01 INFO - Running setup.py (path:/tmp/pip-OQNZ8L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:46:01 INFO - Running setup.py install for manifestparser 03:46:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for mozcrash 03:46:02 INFO - Running setup.py install for mozdebug 03:46:02 INFO - Running setup.py install for mozdevice 03:46:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for mozfile 03:46:02 INFO - Running setup.py install for mozhttpd 03:46:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for mozinfo 03:46:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for mozInstall 03:46:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for mozleak 03:46:02 INFO - Running setup.py install for mozlog 03:46:02 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:46:02 INFO - Running setup.py install for moznetwork 03:46:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Running setup.py install for mozprocess 03:46:03 INFO - Running setup.py install for mozprofile 03:46:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Running setup.py install for mozrunner 03:46:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Running setup.py install for mozscreenshot 03:46:03 INFO - Running setup.py install for moztest 03:46:03 INFO - Running setup.py install for mozversion 03:46:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:46:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:46:03 INFO - Cleaning up... 03:46:03 INFO - Return code: 0 03:46:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:46:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:46:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:46:03 INFO - Using env: {'DISPLAY': ':0', 03:46:03 INFO - 'HOME': '/home/cltbld', 03:46:03 INFO - 'LANG': 'en_US.UTF-8', 03:46:03 INFO - 'LANGUAGE': 'en_US:en', 03:46:03 INFO - 'LOGNAME': 'cltbld', 03:46:03 INFO - 'MAIL': '/var/mail/cltbld', 03:46:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:03 INFO - 'MOZ_NO_REMOTE': '1', 03:46:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:03 INFO - 'NO_EM_RESTART': '1', 03:46:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:03 INFO - 'PWD': '/builds/slave/test', 03:46:03 INFO - 'SHELL': '/bin/bash', 03:46:03 INFO - 'SHLVL': '1', 03:46:03 INFO - 'TERM': 'linux', 03:46:03 INFO - 'TMOUT': '86400', 03:46:03 INFO - 'USER': 'cltbld', 03:46:03 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:03 INFO - '_': '/tools/buildbot/bin/python'} 03:46:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:46:03 INFO - Running setup.py (path:/tmp/pip-q5Nzq6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:46:03 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:46:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:46:03 INFO - Running setup.py (path:/tmp/pip-PmHgkf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:46:04 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:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:46:04 INFO - Running setup.py (path:/tmp/pip-JUZpBx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:46:04 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:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:46:04 INFO - Running setup.py (path:/tmp/pip-Keii8c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:46:04 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:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:46:04 INFO - Running setup.py (path:/tmp/pip-Lcskvf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:46:04 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:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:46:04 INFO - Running setup.py (path:/tmp/pip-EAjWlh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:46:04 INFO - Running setup.py (path:/tmp/pip-beMEDX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:46:04 INFO - Running setup.py (path:/tmp/pip-MKj8pP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:46:04 INFO - Running setup.py (path:/tmp/pip-fOameX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:46:04 INFO - Running setup.py (path:/tmp/pip-XzHh6t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:46:04 INFO - Running setup.py (path:/tmp/pip-cuSrXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:46:04 INFO - Running setup.py (path:/tmp/pip-K9LLnY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:46:04 INFO - Running setup.py (path:/tmp/pip-7yRK4B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:46:04 INFO - Running setup.py (path:/tmp/pip-YY4uUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:04 INFO - Running setup.py (path:/tmp/pip-AZl1rI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:46:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 03:46:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:46:04 INFO - Running setup.py (path:/tmp/pip-m3LDQ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:46:05 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:46:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:46:05 INFO - Running setup.py (path:/tmp/pip-mD24Xn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:46:05 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:46:05 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:46:05 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:46:05 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:46:05 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:46:05 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:46:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:06 INFO - Downloading blessings-1.5.1.tar.gz 03:46:06 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 03:46:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:46:06 INFO - Installing collected packages: blessings 03:46:06 INFO - Running setup.py install for blessings 03:46:07 INFO - Successfully installed blessings 03:46:07 INFO - Cleaning up... 03:46:07 INFO - Return code: 0 03:46:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:46:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:07 INFO - Reading from file tmpfile_stdout 03:46:07 INFO - Current package versions: 03:46:07 INFO - argparse == 1.2.1 03:46:07 INFO - blessings == 1.5.1 03:46:07 INFO - blobuploader == 1.2.4 03:46:07 INFO - docopt == 0.6.1 03:46:07 INFO - manifestparser == 1.1 03:46:07 INFO - mozInstall == 1.12 03:46:07 INFO - mozcrash == 0.16 03:46:07 INFO - mozdebug == 0.1 03:46:07 INFO - mozdevice == 0.47 03:46:07 INFO - mozfile == 1.2 03:46:07 INFO - mozhttpd == 0.7 03:46:07 INFO - mozinfo == 0.9 03:46:07 INFO - mozleak == 0.1 03:46:07 INFO - mozlog == 3.1 03:46:07 INFO - moznetwork == 0.27 03:46:07 INFO - mozprocess == 0.22 03:46:07 INFO - mozprofile == 0.27 03:46:07 INFO - mozrunner == 6.11 03:46:07 INFO - mozscreenshot == 0.1 03:46:07 INFO - mozsystemmonitor == 0.0 03:46:07 INFO - moztest == 0.7 03:46:07 INFO - mozversion == 1.4 03:46:07 INFO - psutil == 3.1.1 03:46:07 INFO - requests == 1.2.3 03:46:07 INFO - wsgiref == 0.1.2 03:46:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:46:07 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:46:07 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:46:07 INFO - Using env: {'DISPLAY': ':0', 03:46:07 INFO - 'HOME': '/home/cltbld', 03:46:07 INFO - 'LANG': 'en_US.UTF-8', 03:46:07 INFO - 'LANGUAGE': 'en_US:en', 03:46:07 INFO - 'LOGNAME': 'cltbld', 03:46:07 INFO - 'MAIL': '/var/mail/cltbld', 03:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:07 INFO - 'MOZ_NO_REMOTE': '1', 03:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:07 INFO - 'NO_EM_RESTART': '1', 03:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:07 INFO - 'PWD': '/builds/slave/test', 03:46:07 INFO - 'SHELL': '/bin/bash', 03:46:07 INFO - 'SHLVL': '1', 03:46:07 INFO - 'TERM': 'linux', 03:46:07 INFO - 'TMOUT': '86400', 03:46:07 INFO - 'USER': 'cltbld', 03:46:07 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:07 INFO - '_': '/tools/buildbot/bin/python'} 03:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 03:46:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 03:46:07 INFO - Cleaning up... 03:46:07 INFO - Return code: 0 03:46:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:46:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:46:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:46:07 INFO - Using env: {'DISPLAY': ':0', 03:46:07 INFO - 'HOME': '/home/cltbld', 03:46:07 INFO - 'LANG': 'en_US.UTF-8', 03:46:07 INFO - 'LANGUAGE': 'en_US:en', 03:46:07 INFO - 'LOGNAME': 'cltbld', 03:46:07 INFO - 'MAIL': '/var/mail/cltbld', 03:46:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:07 INFO - 'MOZ_NO_REMOTE': '1', 03:46:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:07 INFO - 'NO_EM_RESTART': '1', 03:46:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:07 INFO - 'PWD': '/builds/slave/test', 03:46:07 INFO - 'SHELL': '/bin/bash', 03:46:07 INFO - 'SHLVL': '1', 03:46:07 INFO - 'TERM': 'linux', 03:46:07 INFO - 'TMOUT': '86400', 03:46:07 INFO - 'USER': 'cltbld', 03:46:07 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:07 INFO - '_': '/tools/buildbot/bin/python'} 03:46:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:07 INFO - Downloading/unpacking jsonschema 03:46: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:46: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:46: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:46: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:46: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:46: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:46:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 03:46:09 INFO - Downloading/unpacking functools32 (from jsonschema) 03:46: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:46: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:46: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:46: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:46: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:46: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:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 03:46:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:46:09 INFO - warning: no files found matching '*.txt' 03:46:09 INFO - no previously-included directories found matching 'build' 03:46:09 INFO - no previously-included directories found matching 'dist' 03:46:09 INFO - no previously-included directories found matching '.git*' 03:46:09 INFO - Installing collected packages: jsonschema, functools32 03:46:09 INFO - Running setup.py install for functools32 03:46:09 INFO - warning: no files found matching '*.txt' 03:46:09 INFO - no previously-included directories found matching 'build' 03:46:09 INFO - no previously-included directories found matching 'dist' 03:46:09 INFO - no previously-included directories found matching '.git*' 03:46:09 INFO - Successfully installed jsonschema functools32 03:46:09 INFO - Cleaning up... 03:46:09 INFO - Return code: 0 03:46:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 03:46: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:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46: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:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:46:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f16233eef10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1f148a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fe2240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, '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': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', '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:46:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 03:46:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 03:46:09 INFO - Using env: {'DISPLAY': ':0', 03:46:09 INFO - 'HOME': '/home/cltbld', 03:46:09 INFO - 'LANG': 'en_US.UTF-8', 03:46:09 INFO - 'LANGUAGE': 'en_US:en', 03:46:09 INFO - 'LOGNAME': 'cltbld', 03:46:09 INFO - 'MAIL': '/var/mail/cltbld', 03:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:09 INFO - 'MOZ_NO_REMOTE': '1', 03:46:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:09 INFO - 'NO_EM_RESTART': '1', 03:46:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:09 INFO - 'PWD': '/builds/slave/test', 03:46:09 INFO - 'SHELL': '/bin/bash', 03:46:09 INFO - 'SHLVL': '1', 03:46:09 INFO - 'TERM': 'linux', 03:46:09 INFO - 'TMOUT': '86400', 03:46:09 INFO - 'USER': 'cltbld', 03:46:09 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:09 INFO - '_': '/tools/buildbot/bin/python'} 03:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:46:10 INFO - Downloading/unpacking flake8 03:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:46:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:46:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:46:11 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 03:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fflake8-2.5.0-py2.py3-none-any.whl 03:46:11 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 03:46: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:46: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:46: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:46: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:46: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:46: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:46:11 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 03:46:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmccabe-0.3.1-py2.py3-none-any.whl 03:46:11 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 03:46: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:46: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:46: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:46: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:46: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:46: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:46:12 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:46:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 03:46: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:46: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:46: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:46: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:46: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:46: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:46:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 03:46:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 03:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:12 INFO - no previously-included directories found matching 'docs/_build' 03:46:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 03:46:12 INFO - Running setup.py install for pep8 03:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 03:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 03:46:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 03:46:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 03:46:12 INFO - no previously-included directories found matching 'docs/_build' 03:46:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 03:46:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 03:46:12 INFO - Cleaning up... 03:46:12 INFO - Return code: 0 03:46:12 INFO - Running post-action listener: _resource_record_post_action 03:46:12 INFO - Running post-action listener: _start_resource_monitoring 03:46:12 INFO - Starting resource monitoring. 03:46:12 INFO - ##### 03:46:12 INFO - ##### Running install step. 03:46:12 INFO - ##### 03:46:12 INFO - Running pre-action listener: _resource_record_pre_action 03:46:12 INFO - Running main action method: install 03:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:46:12 INFO - Reading from file tmpfile_stdout 03:46:12 INFO - Detecting whether we're running mozinstall >=1.0... 03:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:46:12 INFO - Reading from file tmpfile_stdout 03:46:12 INFO - Output received: 03:46:12 INFO - Usage: mozinstall [options] installer 03:46:12 INFO - Options: 03:46:12 INFO - -h, --help show this help message and exit 03:46:12 INFO - -d DEST, --destination=DEST 03:46:12 INFO - Directory to install application into. [default: 03:46:12 INFO - "/builds/slave/test"] 03:46:12 INFO - --app=APP Application being installed. [default: firefox] 03:46:12 INFO - mkdir: /builds/slave/test/build/application 03:46:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 03:46:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 03:46:27 INFO - Reading from file tmpfile_stdout 03:46:27 INFO - Output received: 03:46:27 INFO - /builds/slave/test/build/application/firefox/firefox 03:46:27 INFO - Running post-action listener: _resource_record_post_action 03:46:27 INFO - ##### 03:46:27 INFO - ##### Running run-tests step. 03:46:27 INFO - ##### 03:46:27 INFO - Running pre-action listener: _resource_record_pre_action 03:46:27 INFO - Running main action method: run_tests 03:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:46:27 INFO - Python 2.7.3 03:46:27 INFO - Return code: 0 03:46:27 INFO - grabbing minidump binary from tooltool 03:46:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:46:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x20710b0>, '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 0x2071fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2072440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:46:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 03:46:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 03:46:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:46:27 INFO - Return code: 0 03:46:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:46:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:46:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:46:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:46:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:46:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 03:46:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 03:46:28 INFO - Return code: 0 03:46:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] in /builds/slave/test/build 03:46:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-010 --webServer localhost 03:46:28 INFO - Using env: {'DISPLAY': ':0', 03:46:28 INFO - 'HOME': '/home/cltbld', 03:46:28 INFO - 'LANG': 'en_US.UTF-8', 03:46:28 INFO - 'LANGUAGE': 'en_US:en', 03:46:28 INFO - 'LOGNAME': 'cltbld', 03:46:28 INFO - 'MAIL': '/var/mail/cltbld', 03:46:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:46:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:46:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:46:28 INFO - 'MOZ_NO_REMOTE': '1', 03:46:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:46:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:46:28 INFO - 'NO_EM_RESTART': '1', 03:46:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:46:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:46:28 INFO - 'PWD': '/builds/slave/test', 03:46:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:46:28 INFO - 'SHELL': '/bin/bash', 03:46:28 INFO - 'SHLVL': '1', 03:46:28 INFO - 'TERM': 'linux', 03:46:28 INFO - 'TMOUT': '86400', 03:46:28 INFO - 'USER': 'cltbld', 03:46:28 INFO - 'XDG_SESSION_COOKIE': 'cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409', 03:46:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:46:28 INFO - '_': '/tools/buildbot/bin/python'} 03:46:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-010', '--webServer', 'localhost'] with output_timeout 3600 03:46:28 INFO - mozversion INFO | application_buildid: 20151211023240 03:46:28 INFO - mozversion INFO | application_changeset: 5562d39c90da9eb2de1ab212098cd5f1af1a6066 03:46:28 INFO - mozversion INFO | application_display_name: Nightly 03:46:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:46:28 INFO - mozversion INFO | application_name: Firefox 03:46:28 INFO - mozversion INFO | application_remotingname: firefox 03:46:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 03:46:28 INFO - mozversion INFO | application_vendor: Mozilla 03:46:28 INFO - mozversion INFO | application_version: 45.0a1 03:46:28 INFO - mozversion INFO | platform_buildid: 20151211023240 03:46:28 INFO - mozversion INFO | platform_changeset: 5562d39c90da9eb2de1ab212098cd5f1af1a6066 03:46:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 03:46:28 INFO - mozversion INFO | platform_version: 45.0a1 03:46:28 INFO - 2015-12-11 03:46:28,721 DEBUG : using testdate: 1449834388 03:46:28 INFO - 2015-12-11 03:46:28,721 DEBUG : actual date: 1449834388 03:46:28 INFO - 2015-12-11 03:46:28,840 INFO : starting webserver on 'localhost:41521' 03:46:28 INFO - 2015-12-11 03:46:28,841 INFO : Starting test suite talos-linux64-ix-010 03:46:28 INFO - 2015-12-11 03:46:28,842 INFO : Starting test dromaeo_css 03:46:28 INFO - 2015-12-11 03:46:28,842 DEBUG : operating with platform_type : linux_ 03:46:28 INFO - 2015-12-11 03:46:28,842 INFO : Initialising browser for dromaeo_css test... 03:46:28 INFO - 2015-12-11 03:46:28,857 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v3GDj/profile http://localhost:41521/getInfo.html 03:46:33 INFO - 2015-12-11 03:46:33,107 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:46:33 INFO - 2015-12-11 03:46:33,107 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:46:33 INFO - 2015-12-11 03:46:33,107 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:46:33 INFO - 2015-12-11 03:46:33,107 DEBUG : BROWSER_OUTPUT: __metrics 03:46:33 INFO - 2015-12-11 03:46:33,276 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:46:33 INFO - 2015-12-11 03:46:33,324 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:46:33 ERROR - 2015-12-11 03:46:33,339 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 03:46:34 INFO - 2015-12-11 03:46:34,476 INFO : Browser initialized. 03:46:34 INFO - 2015-12-11 03:46:34,477 INFO : Running cycle 1/1 for dromaeo_css test... 03:46:34 INFO - 2015-12-11 03:46:34,477 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4v3GDj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:46:46 INFO - 2015-12-11 03:46:46,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 142938112 03:46:46 INFO - 2015-12-11 03:46:46,494 DEBUG : BROWSER_OUTPUT: 03:47:37 INFO - 2015-12-11 03:47:37,696 DEBUG : BROWSER_OUTPUT: 1449834457696 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:49:49 INFO - 2015-12-11 03:49:49,789 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41521/tests/dromaeo/cssquery-ext.html) 03:49:50 INFO - 2015-12-11 03:49:50,981 DEBUG : BROWSER_OUTPUT: RSS: Main: 263036928 03:49:50 INFO - 2015-12-11 03:49:50,981 DEBUG : BROWSER_OUTPUT: 03:52:53 INFO - 2015-12-11 03:52:53,539 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-ext.html (next: http://localhost:41521/tests/dromaeo/cssquery-jquery.html) 03:52:54 INFO - 2015-12-11 03:52:54,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 221433856 03:52:54 INFO - 2015-12-11 03:52:54,112 DEBUG : BROWSER_OUTPUT: 03:55:56 INFO - 2015-12-11 03:55:56,156 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41521/tests/dromaeo/cssquery-mootools.html) 03:55:56 INFO - 2015-12-11 03:55:56,729 DEBUG : BROWSER_OUTPUT: RSS: Main: 214781952 03:55:56 INFO - 2015-12-11 03:55:56,729 DEBUG : BROWSER_OUTPUT: 03:58:58 INFO - 2015-12-11 03:58:58,644 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41521/tests/dromaeo/cssquery-prototype.html) 03:58:59 INFO - 2015-12-11 03:58:59,238 DEBUG : BROWSER_OUTPUT: RSS: Main: 202235904 03:58:59 INFO - 2015-12-11 03:58:59,238 DEBUG : BROWSER_OUTPUT: 04:02:02 INFO - 2015-12-11 04:02:02,048 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41521/tests/dromaeo/cssquery-yui.html) 04:02:02 INFO - 2015-12-11 04:02:02,649 DEBUG : BROWSER_OUTPUT: RSS: Main: 207196160 04:02:02 INFO - 2015-12-11 04:02:02,649 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/dromaeo/cssquery-yui.html (next: http://localhost:41521/tests/dromaeo/cssquery-dojo.html) 04:05:05 INFO - 2015-12-11 04:05:05,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 250441728 04:05:05 INFO - 2015-12-11 04:05:05,409 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2602.7527384898435;2696.7303269673034;2698.8650567471623;2715.511207982562;2727.345437095097;4480.955190448095;4598.0344127733215;4654.3716598259225;4682.601978831799;4689.390379250697;4544.9091018179615;4582.427196600425;4585.358049873021;4591.563801438858;4611.7924693388795;4261.318189089746;4324.394584758136;4340.696151269412;4385.386045953569;4391.714538554999;4377.365282034103;4378.1462614790125;4386.204025395373;4452.10957808438;4452.599266066053;4177.6866734995;4273.465816772903;4400.647948164139;4436.4676238851225;4444.577765112309;4217.367394890791;4233.280342341809;4243;4247.469066366704;4249.107687385653;4248.596383343577;4258.510271318807;4263.275243208662;4265.744055356658;4273.572642735733;4474.664400170001;4556.635469162459;4565.2467342888385;4590.472095708969;4597.080583883237;4989.301497790312;4991.351124353847;4993.550580447741;4999.275105109738;5034.748262586892;4795.352627395292;4902.65681402302;5015.673981191248;5020.2720605511995;5029.572486338666;4521.480029796583;4620.653450991189;4692.319613656069;4697.013627138339;4732.195526760459;5067.594592432597;5108.080545501845;5108.591312694975;5113.948860511422;5168.095583272912;4776.9761151194025;4883.4628190898975;4921.409430868247;4928.408590969035;4940.160172770566;4853.611711063107;4913;4930.334404855299;4939.234418665113;4984.352034235526;4929.507049295042;4991.301217829507;4992.151334273182;5011.523905228997;5026.4973502649445;4731.787069581877;4843.15244832153;4956.3804524434445;4973.42805577356;5017.724025178577;4047.4131250969035;4076.7146299759324;4087.448194493705;4103.938440923389;4141.585841415835;3601.5678118625933;3605.94591081134;3626.8911932642063;3650.7809531428197;3657.6159503252306;4135.545090040093;4248.129133527619;4337.913241735211;4340.197063543192;4356.4336636237085;4834.854954351375;4895.33912921751;4907.190313598217;4928.433230178503;4945.010997800382;4291.098869237433;4337.15425492026;4349.217140914666;4379.167958087953;4391.626711729475;4206.831726730958;4316.676249281317;4451.755153466591;4461.531539188339;4461.7992190351515;4684.906301873943;4798.49615790344;4856.417229932289;4880.585150262267;4921.876953076202;5002.924956125734;5006.774695138654;5032.949670503248;5039.596832253337;5075.644704870623;4575.7483338416705;4678.204705200193;4817.662763606514;4837.032593481388;4872.707637541759;4798.808047678054;4851.660383773102;4861.586765125004;4879.926801098058;4917.754112294299;4991.176455884738;5004.174311238605;5008.974955125201;5023.874403139805;5035.446100928822;4631.930521042254;4735.550122738335;4804.399450068741;4850.5149485052625;4890.070886531547;4709.882252943704;4780.569748722632;4792.976035119802;4800.255960326155;4802.471728109836;4663.044075964352;4666.929996049994;4670.416197975253;4701.529847015271;4715.3869996900185;4746.596539294061;4798.592119669867;4804.639652026042;4814.879628009187;4836.153673107263;4709.81160753566;4737.976310118427;4756.6908150970075;4758.16732071893;4792.496787837366 04:05:05 INFO - 2015-12-11 04:05:05,410 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.327606871754;571.225988785196;575.0884847516687;579.0070029898723;580.4717706886734;26731.331716707093;35555.28889422213;36176;36238.2752344953;36256.274874502495;39463.80268098663;39912;39938.40092398609;39999.20001599966;40009.59990400095;6879.587224766505;6978.8953165702305;7887.408444366681;8061.395395345343;8072.273495385414;10077.949610251939;10324.638637647684;10338;10346.637867674634;10355.11981481575;10009.499525023755;10074.34516756412;10106.747331316703;10107.888132305441;10109.545070471846;7004.544704594211;7103.928960710378;7104.43164546835;9995.95002024989;10165.085142337226;9819.263555233387;9938.652147174886;9951.701448956543;9954.601815927354;9963.601455941754;37215.441768373494;37632.43551346732;37638.62361376378;37645;37660.24679506422;2852.942941141186;2877.3813630069426;2893.3056066544086;3056.037348235321;3346.9330613387597;28539.57190642142;28719.856400718072;28746.425071498452;28793;29087;3374.139594403436;3394.2023624448234;3394.4738565522384;3464.2378676691087;3474.2183008823067;216166;216491;216728;216891;217704.99999999843;44296.114077718266;45239.321410178876;53183.20225196625;53615.73192134014;53625;56539.71730141405;57894.94735368568;58334.4166558329;58388.4161158383;58428.12357814636;13050.347482625832;13164.539241126515;13236.404361803741;13277.004224682994;13310;9543.522823858919;9558.661787349776;9582.089701478348;9641.27690423207;9687.321887467951;17808.554786130193;18166.455006349832;18272.451826445227;18285.908570457064;18359.806612570406;7235.237676408238;7385.852282954311;7404.629768511553;7516.210797866254;7599.4680372373405;777.809436688015;789.632820738348;882.0958517519593;905.3526728389234;923.9882328849899;25953.870230648725;26142.582273419972;26276.343091422485;26406.339841503734;26543;893.8882639670041;909.8544232922833;1037.2946396450336;1040.0119886108228;1087.543231842628;13761.4541309858;13828.819649806423;13921.164730116225;13936.930315348562;14014.789778153336;344594;347997;348050;348708;348791;39273.607263927566;43194.352084718754;43518.34722479165;43657.781711091244;43758.34362484565;1038.345842119475;1177.1877404590634;1194.599809063956;1196.7008247938015;1271.841019872516;23348.416289592897;23586.646200307354;23619.763802361755;24009.399765005317;24055.158069467485;32082.358352832347;32562.837185813918;35868.282634346644;36653;36674.8166259167;315970.08358997066;319437;321470;321736;322076;26965.494485716732;27334.1799746;27348.863255683595;27398.72601273962;27413.725862741117;37563;38155.618443815205;38426.807865960494;38530;38837.80581097076;31261.8436907814;32599;33317.16707082342;33611.3277734439;33827.66172338245;27470.450590987668;27493.725062749116;27579.448411031266;27824.72175278302;27983.720162798927;31964.360712786078;32223.516647250777;32344.676553234167;32601.673983259865;32684.673153268162;28968.7103128966;29181.7081829179;29794.70205297919;29887.252818679706;29907.850460747555;22897;23233.419164521023;23341.88329058344;24170.51658966846;25312 04:05:05 INFO - 2015-12-11 04:05:05,411 DEBUG : BROWSER_OUTPUT: |2;jquery.html;336.2551947436428;338.8695352289371;340.19883175122584;340.50966608084354;341.2169071979806;12413.193142445734;12778.744425111492;14683.559493215207;14930.477433289838;16418.014919104848;11727.706807329821;12735.872641273607;13517.32413379332;14669.339879705412;14698.706025879475;4708.270218116198;4962.379702537183;4969.329140566014;4970.776315065813;4971;3654.1960768630993;3761.0221342450886;4879.024195160964;4919.655624106314;4941.283513890484;5499.285092937933;5628.662280263176;5655.971720141414;5656.575756818234;5670.404607516213;5494.725263736817;5635.549156067505;5650.180723795047;5669.489745922846;5675.120356344773;5000.949990500085;5002.699838009731;5005.3242812220615;5005.449400565934;5007.273945277951;18960;19484.123214455383;19692.113854876567;19755.604887902304;19789.10949007284;1867.421099459172;1879.1731638079339;1884.1615481110912;1898.136347961688;1931.951701207467;12783.424745886457;12911.741765164645;13092.214467132002;13127.737445251138;13201.669958251025;1676.2373120230388;1686.0766561640041;1782.3138091834608;1793.5874748807717;1796.91015449227;50167.74916125396;51402.7429862852;52145.2178217327;53419;54628.72685636586;8386.580670966427;8826.117388261122;9513.143817056498;9527.28545359087;9539.379940303857;12265.69335766613;12269.202501837352;12286.447109880077;12293.508259669692;12314.753704925852;6374.330695277022;6377.5216858735785;6420.454261387741;6503.772367967098;6572.901406478906;6018.187544681412;6058.242719660043;6059.909101363483;6074.301455332605;6119.816405507842;3856.82644281008;3964.207158568298;3991.261616600938;4074.246264441088;4243.6605071594195;1603.4708546179966;1645.2267434305857;1663.8835281530178;1717.519094653499;1719.6904557179828;813.8046868751456;817.852786498436;819.0908092017855;853.2235665544449;951.690700522333;15382.230888455533;15536.300866461037;15658.217089145497;15731.528054158394;16102.838971610368;710.4884483172108;801.8997625296838;857.4298091768903;881.5415983688446;925.3337596930199;8278.710245141512;8425.36809739272;8436.957815211008;8584.141585841366;8618.138186181332;461300;469140;470412;470671;477235;65746.67126664432;67617;68010;68252.31747682558;69457.3054269461;1028.4497793680496;1032.2464600841429;1051.8895515970867;1057.735566108473;1062.4846949229773;13122.803157952829;13370.665733356744;13391.598252052454;13409.32953352348;13645;30329.69670303269;30388.544171837;31186.376272474878;31269.374612507167;31395.372092557565;41384.58615413807;41706;44285.557144428145;44382.77808610936;44420.55579444164;8943.418677785923;9013.098690130935;9034.819303614022;9093.727188184364;9188.816223675356;15945.601359966093;16398.508044758677;16524.173791310146;16620.750688739437;16643.75034374461;13450.663733406744;13640.727185456037;13676.794848077088;14095.473658174622;14232.146071235758;12852.421641026363;12860.228386296852;13631.727365452438;13931.58205253844;13987.930060349634;10987.780244394908;13951.23268220217;14079.788803168165;14246;14276.21480818565;8440.957795210985;8679.26226270774;8763.518006509448;8766.254868336262;8781.25359344463;9268.72193834186;9901.950490247502;13480.393382297623;13579.185248885098;13732.519361822688 04:05:05 INFO - 2015-12-11 04:05:05,414 DEBUG : BROWSER_OUTPUT: |3;mootools.html;680.826389270736;1611.911344876032;1649.200137933103;1683.5370273174876;1760.2430954689482;5777.82666520004;6735.8989615155815;6829.897551536725;6832.760853370133;6848.383645471907;6676.833079173023;6822.59064456133;6832;6848.486363522743;6860;2069.855110142287;2106.9367918962457;2114.587655407196;2119.173522326294;2121.1091341636475;1922.327185485076;1922.7404300419473;1934.6614342490009;1953.6092781443697;1962.9705554416696;1910.6751852185162;1914.6745053340965;1939.5442071113278;1941.3981665683684;1943.1644392911044;1979.8020197980159;2004.5790384019374;2008.2970960163973;2009.859309848311;2014.29499675114;2043.5708501214763;2049.8565100442975;2063.1953538120147;2084.937451876431;2087.812096911285;6781.762638307636;6860.485463590201;6863.039174515572;6875.690593923286;6883.070785444002;4113.629773320416;4170.979145104286;4182.874513764592;4184.623383895434;4190.266703326936;2619.3320703220747;2631.3421644588852;2668.6263923050788;2745.0666773296975;2748.038186634682;839.1692224697566;843.28320927212;855.6575379946795;864.0754392799707;873.3362644390309;9427.717168484956;9551.1403973642;9558.617655293849;9609.183219426357;9633.614655413776;3793.468914351993;3808.2383523295453;3860.0735823402183;3872.593377695358;3875.9612403876163;8399.37004724648;8419.368547358972;8430.662773488992;8433.072362040171;8437.535935523605;4142.047329114321;4188.979055104705;4189.099343641132;4190.20386126635;4196.853110141131;3222.516622506596;3273.3289675616916;3739.121306492972;3788.8673896413493;3811;3448.74134439918;3469.7224222062678;3473.4616134499192;3479.2171761353493;3498.9475157872653;1076.4563895233014;1093.8359246112987;1094.950727217277;1099.367863478503;1102.8511150994673;817.448222449844;847.8261956298944;911.290202888227;979.2117345536769;1199.8680145184023;6618.933810661832;6708.530402871752;6719.361660642231;6721.092652491949;6721.361470660279;520.6901893373437;521.7991073436755;533.3519773475247;537.2746791830997;686.9210040845267;4965.776540055706;5022.2466630005065;5074.949250507448;5084.110280700863;5092.28707980883;8129.756107316672;8500.914990850013;8595.269402100892;8605.612747426381;8607.913920860836;8419.831603367898;8483.557795174835;8498.277646400125;8535.615897284637;8536.8719469208;6232.56372053961;6495.577787443895;6500.837479062967;6700.296468870796;6743.325667433218;6537.771178008938;6576.046473261446;6583.967080164569;6584.670766461562;6589.439897608565;7203.783886483414;7361.2638736125955;7383.815404614713;7446.962765186356;7488.400927925862;7656.961715191388;7788.844223115392;8166.6733330668485;8265.710700125466;8274.669013239403;6185;6201.348858369986;6245.469135123565;6252;6264.874702506016;6885.311468853075;6988.475864310299;6995.545289556163;6996.895046574407;6999.09011828459;6259.561830671809;6273.749050037947;6361.809145725636;6375.139356186855;6409.359064093554;4839.588634966068;6179;6266.968665156827;6271.153394291712;6435.06691529735;6217.253929528486;6296.811095667137;6297.370262973666;6307.653079080695;6311.96844015777;5868.765249390148;5896.115582662635;5898.469137777621;5905.350411454822;5916.230889984275;5877.177195192762;5883.529317654663;5892;5926.851828704317;5934.525237981037 04:05:05 INFO - 2015-12-11 04:05:05,416 DEBUG : BROWSER_OUTPUT: |4;prototype.html;308.8918878392563;316.18739838614755;319.7569846916343;322.0467416447316;322.73535700725387;5106.872328191797;5290.841274761754;5301.5228629423345;5323.254744335796;5327.973360133194;5144.202648589475;5207.609429292808;5212.061828870802;5221.190715439113;5241.3186285782895;3800.182960663457;3900.4344370066324;3929.5873933236885;4037.97981010096;4041.1513582147636;4020.3165461871404;4028.81870315835;4037.333839916425;4040;4041.959580404188;3996.6802655787615;3999.060220848098;4001.539822920358;4001.5798341174195;4005.719599628027;3781.300459415017;3875.1280961783655;3880.708946828999;3966.5240171179353;3968.583298753647;3489.91275218119;3496.4056110461283;3497.3005398920063;3508.5965114011706;3509.491123787062;4937.851864444073;4943.6539442239055;4944.283078953532;4948.713334533011;4951.90096198074;4581.266997280452;4585.220512512881;4589.655775816827;4591.311303304497;4593.63250939924;5309.523217350235;5380.166074258496;5409.594280428944;5418.810341638024;5429.972850135763;3824.368979118442;3827.7129215308687;3829.617038296148;3829.9808500957597;3830.808459577038;5621.353544342412;5703.173039909231;5709.143628455723;5709.229254050691;5712.742926568314;3931.4692516510477;3932.9606703932595;3938.428927805452;3942.42834788954;3944.15200731844;3649.7773245962367;3717.1078941054493;3997.260506806192;3999.320115580358;4005.1989602079702;4343.348497725303;4453.532379100213;4455.6658250631335;4459.620932220732;4483.843065492692;5391.676499410048;5436.592255580847;5460.563154947595;5468.125099984063;5473.31583552056;1392.1438315435935;1413.8656827601362;1414.370605080729;1416.369715476603;1416.7591509443419;946.536197263336;965.358036905464;965.5365424596233;978.1685567267907;981.9901800982042;4815.614750819926;4835.202191638411;4837.612990960714;4838.03239352131;4845.927311090337;5618.157276408571;5623.10030395143;5629.549636029108;5633.0987042073075;5639.2668953035845;4817.940053188293;4822.662413631082;4825.059113472839;4825.5174482551465;4827.300041494034;2864.9283767905968;2916.2709322669334;2998.190488568074;3005.4740420426338;3019.879204831826;5416.593755468356;5432.293801805819;5437.945620543823;5450.400455949843;5451.373092094381;5797.391273916178;5813.128030795415;5816.621919575214;5819.010768169422;5827.038538641162;5311.548518375981;5431.6740995540395;5432.701201433959;5436.075867102523;5440.102383106743;5659.236003139524;5677;5677.375488696158;5682.886342273214;5683.090705487102;5558.694271815089;5560.165975103767;5560.221568980265;5565.415631358649;5572.526335261386;5433.538149257357;5438.972805135949;5441.673499590037;5448.264484294569;5450.754716037867;3785.2240290739783;3929.0766669833138;3936.488256526633;3966.206758648224;3970.4441378206498;5564.4713752193475;5568.136938774334;5568.582356323373;5569.248151499496;5569.805056822992;5361.946380536145;5370.677759334452;5371.650842695212;5372.221027950847;5372.677639341652;5363.383210930793;5372.409035006224;5374.167004114369;5377.650452720561;5381.811636592701;5134.589232861287;5255.605829562722;5263.23683065961;5267.0256002639635;5267.420583735862;5391.541718953933;5391.9460805391445;5410.1343784994215;5410.945890541044;5414.593905457028;5260.921086183634;5261.210818377274;5266.815661451831;5274.472552744694;5276.525112739719 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: |5;yui.html;761.9504732192407;780.127693535515;794.447858738177;800.9359251259896;803.120582961657;13091.279979601119;13375.665608359795;13394.933025334873;13398.464061437531;13411.46354145833;12146.210496317755;12165.270083794978;12280.508779648804;12286.93856530716;12314.753704925895;645.7642960319497;646.4020780777785;650.9739610415578;816.9428140030216;833.4665813879122;638.2054342343765;646.1245013007377;647.8866198415259;812.7196117339508;827.6606591297569;861.2378045429808;865.1219012702112;869.613022205119;870.5386145342978;870.8911386076741;668.6890595872942;863.3611127765471;863.5811631358786;864.3215076165211;866.6836604639325;497.46274024053935;628.5003422279253;635.7933671556763;637.968101594923;638.0238235499646;12301.507939682491;12425.130240883142;12446.751064978649;12458.252504849737;12468.127231093828;10548.31435956668;10630.681079567625;10740.677779666623;11420.942895285554;11551.53793848245;9051.683191088347;9198.67804626835;9204.539773011322;9408.341416100875;9438.244940404751;3184.1561986073707;3211.951820722691;3237.14215732831;3269.722073623745;3328.3842489139342;38840.80579597112;38894.41658375126;39232.80383598092;39248.215035699126;39439.8028009861;9034.503102329303;9161.862572061424;9191.862122068174;9260.907390926004;9369.344145909858;16115.113668748098;16130.677386452206;16181.59546011359;16199.919000404923;16216.351345946267;6268.968655156695;6315.463185629181;6345.841353966188;6356.968215158895;6577.934220657828;3453.533772940671;3454.654534546525;3500.8272228803635;3518.7009104226427;3532.699720523733;2764.3089227693076;2768.2525718056413;2770.9307267318077;2771.3210263485576;2794.3712664650293;471.48608017261347;480.0926249388658;487.0721275969284;490.92636104584597;491.9483454237325;281.91542537238746;440.99559004410185;446.8681738887036;475.9857204283877;525.5296509623865;7063.434925205971;7246.109613477721;7281.526700764433;7335.376492998155;7402.29678180572;376.47293788696044;384.6480470369581;448.97857374473335;498.6933036182721;552.850730302824;3137.341158356725;3271.1004473769904;3469;3505.2288496530723;3610.7472476926887;46943;47522.28716569254;47756.5224347759;47818.52181478141;48118;40792.79603602023;41111.58888411077;41840;41925.79037104795;41939.37090943638;38883.416748748794;38975.220495590496;39048;39538.604613953496;39747.20505589872;7462.626868656654;7635.350995165473;7664.655090520829;7790.766277011699;7795.64919578609;29182;29473.410531789672;29682.851585741933;29785.10644680663;29851.10446686603;36093;36189.63810361968;37413.2517349646;38089.809550952064;38240.61759382371;9685.176759975198;9707.417554946725;10162.085412312927;10232.948835256075;10235.334703244265;10710.357378557312;10973.286736362112;10997.230193886671;11158.497867595815;11289.435528223392;10697.358158510515;10745.838812417976;10806.297590656897;10845.945770271099;10876.51055702511;9717.465539395402;10268.845967310346;10485.52815123306;10799.13606911461;10824.5128969195;8774.473531588124;9074.773130671787;9955.253355998473;10252.897471025195;10681.839772403575;8875.423097498642;8996.325275604226;9368.344215905094;9557.52212389364;10072.093511583993;9300.906990930003;9311.72064838056;9431.528423578931;9511.904880951102;9513.714588562354 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1027 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835505403__endTimestamp 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:05:05 INFO - 2015-12-11 04:05:05,417 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:05:05 INFO - 2015-12-11 04:05:05,418 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,418 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4587.75 Median:4709.81 stddev:471.93 (10.0%) stddev-sans-first:446.95 04:05:05 INFO - 2015-12-11 04:05:05,418 DEBUG : BROWSER_OUTPUT: Values: 2602.8 2696.7 2698.9 2715.5 2727.3 4481.0 4598.0 4654.4 4682.6 4689.4 4544.9 4582.4 4585.4 4591.6 4611.8 4261.3 4324.4 4340.7 4385.4 4391.7 4377.4 4378.1 4386.2 4452.1 4452.6 4177.7 4273.5 4400.6 4436.5 4444.6 4217.4 4233.3 4243.0 4247.5 4249.1 4248.6 4258.5 4263.3 4265.7 4273.6 4474.7 4556.6 4565.2 4590.5 4597.1 4989.3 4991.4 4993.6 4999.3 5034.7 4795.4 4902.7 5015.7 5020.3 5029.6 4521.5 4620.7 4692.3 4697.0 4732.2 5067.6 5108.1 5108.6 5113.9 5168.1 4777.0 4883.5 4921.4 4928.4 4940.2 4853.6 4913.0 4930.3 4939.2 4984.4 4929.5 4991.3 4992.2 5011.5 5026.5 4731.8 4843.2 4956.4 4973.4 5017.7 4047.4 4076.7 4087.4 4103.9 4141.6 3601.6 3605.9 3626.9 3650.8 3657.6 4135.5 4248.1 4337.9 4340.2 4356.4 4834.9 4895.3 4907.2 4928.4 4945.0 4291.1 4337.2 4349.2 4379.2 4391.6 4206.8 4316.7 4451.8 4461.5 4461.8 4684.9 4798.5 4856.4 4880.6 4921.9 5002.9 5006.8 5032.9 5039.6 5075.6 4575.7 4678.2 4817.7 4837.0 4872.7 4798.8 4851.7 4861.6 4879.9 4917.8 4991.2 5004.2 5009.0 5023.9 5035.4 4631.9 4735.6 4804.4 4850.5 4890.1 4709.9 4780.6 4793.0 4800.3 4802.5 4663.0 4666.9 4670.4 4701.5 4715.4 4746.6 4798.6 4804.6 4814.9 4836.2 4709.8 4738.0 4756.7 4758.2 4792.5 04:05:05 INFO - 2015-12-11 04:05:05,418 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,418 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44185.31 Median:32600.34 stddev:78939.45 (242.1%) stddev-sans-first:79092.94 04:05:05 INFO - 2015-12-11 04:05:05,419 DEBUG : BROWSER_OUTPUT: Values: 560.3 571.2 575.1 579.0 580.5 26731.3 35555.3 36176.0 36238.3 36256.3 39463.8 39912.0 39938.4 39999.2 40009.6 6879.6 6978.9 7887.4 8061.4 8072.3 10077.9 10324.6 10338.0 10346.6 10355.1 10009.5 10074.3 10106.7 10107.9 10109.5 7004.5 7103.9 7104.4 9996.0 10165.1 9819.3 9938.7 9951.7 9954.6 9963.6 37215.4 37632.4 37638.6 37645.0 37660.2 2852.9 2877.4 2893.3 3056.0 3346.9 28539.6 28719.9 28746.4 28793.0 29087.0 3374.1 3394.2 3394.5 3464.2 3474.2 216166.0 216491.0 216728.0 216891.0 217705.0 44296.1 45239.3 53183.2 53615.7 53625.0 56539.7 57894.9 58334.4 58388.4 58428.1 13050.3 13164.5 13236.4 13277.0 13310.0 9543.5 9558.7 9582.1 9641.3 9687.3 17808.6 18166.5 18272.5 18285.9 18359.8 7235.2 7385.9 7404.6 7516.2 7599.5 777.8 789.6 882.1 905.4 924.0 25953.9 26142.6 26276.3 26406.3 26543.0 893.9 909.9 1037.3 1040.0 1087.5 13761.5 13828.8 13921.2 13936.9 14014.8 344594.0 347997.0 348050.0 348708.0 348791.0 39273.6 43194.4 43518.3 43657.8 43758.3 1038.3 1177.2 1194.6 1196.7 1271.8 23348.4 23586.6 23619.8 24009.4 24055.2 32082.4 32562.8 35868.3 36653.0 36674.8 315970.1 319437.0 321470.0 321736.0 322076.0 26965.5 27334.2 27348.9 27398.7 27413.7 37563.0 38155.6 38426.8 38530.0 38837.8 31261.8 32599.0 33317.2 33611.3 33827.7 27470.5 27493.7 27579.4 27824.7 27983.7 31964.4 32223.5 32344.7 32601.7 32684.7 28968.7 29181.7 29794.7 29887.3 29907.9 22897.0 23233.4 23341.9 24170.5 25312.0 04:05:05 INFO - 2015-12-11 04:05:05,419 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,419 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25577.52 Median:3910.52 stddev:76653.76 (1960.2%) stddev-sans-first:76845.36 04:05:05 INFO - 2015-12-11 04:05:05,420 DEBUG : BROWSER_OUTPUT: Values: 336.3 338.9 340.2 340.5 341.2 12413.2 12778.7 14683.6 14930.5 16418.0 11727.7 12735.9 13517.3 14669.3 14698.7 4708.3 4962.4 4969.3 4970.8 4971.0 3654.2 3761.0 4879.0 4919.7 4941.3 5499.3 5628.7 5656.0 5656.6 5670.4 5494.7 5635.5 5650.2 5669.5 5675.1 5000.9 5002.7 5005.3 5005.4 5007.3 18960.0 19484.1 19692.1 19755.6 19789.1 1867.4 1879.2 1884.2 1898.1 1932.0 12783.4 12911.7 13092.2 13127.7 13201.7 1676.2 1686.1 1782.3 1793.6 1796.9 50167.7 51402.7 52145.2 53419.0 54628.7 8386.6 8826.1 9513.1 9527.3 9539.4 12265.7 12269.2 12286.4 12293.5 12314.8 6374.3 6377.5 6420.5 6503.8 6572.9 6018.2 6058.2 6059.9 6074.3 6119.8 3856.8 3964.2 3991.3 4074.2 4243.7 1603.5 1645.2 1663.9 1717.5 1719.7 813.8 817.9 819.1 853.2 951.7 15382.2 15536.3 15658.2 15731.5 16102.8 710.5 801.9 857.4 881.5 925.3 8278.7 8425.4 8437.0 8584.1 8618.1 461300.0 469140.0 470412.0 470671.0 477235.0 65746.7 67617.0 68010.0 68252.3 69457.3 1028.4 1032.2 1051.9 1057.7 1062.5 13122.8 13370.7 13391.6 13409.3 13645.0 30329.7 30388.5 31186.4 31269.4 31395.4 41384.6 41706.0 44285.6 44382.8 44420.6 8943.4 9013.1 9034.8 9093.7 9188.8 15945.6 16398.5 16524.2 16620.8 16643.8 13450.7 13640.7 13676.8 14095.5 14232.1 12852.4 12860.2 13631.7 13931.6 13987.9 10987.8 13951.2 14079.8 14246.0 14276.2 8441.0 8679.3 8763.5 8766.3 8781.3 9268.7 9902.0 13480.4 13579.2 13732.5 04:05:05 INFO - 2015-12-11 04:05:05,421 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,421 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4889.19 Median:6239.02 stddev:2582.82 (41.4%) stddev-sans-first:2570.68 04:05:05 INFO - 2015-12-11 04:05:05,421 DEBUG : BROWSER_OUTPUT: Values: 680.8 1611.9 1649.2 1683.5 1760.2 5777.8 6735.9 6829.9 6832.8 6848.4 6676.8 6822.6 6832.0 6848.5 6860.0 2069.9 2106.9 2114.6 2119.2 2121.1 1922.3 1922.7 1934.7 1953.6 1963.0 1910.7 1914.7 1939.5 1941.4 1943.2 1979.8 2004.6 2008.3 2009.9 2014.3 2043.6 2049.9 2063.2 2084.9 2087.8 6781.8 6860.5 6863.0 6875.7 6883.1 4113.6 4171.0 4182.9 4184.6 4190.3 2619.3 2631.3 2668.6 2745.1 2748.0 839.2 843.3 855.7 864.1 873.3 9427.7 9551.1 9558.6 9609.2 9633.6 3793.5 3808.2 3860.1 3872.6 3876.0 8399.4 8419.4 8430.7 8433.1 8437.5 4142.0 4189.0 4189.1 4190.2 4196.9 3222.5 3273.3 3739.1 3788.9 3811.0 3448.7 3469.7 3473.5 3479.2 3498.9 1076.5 1093.8 1095.0 1099.4 1102.9 817.4 847.8 911.3 979.2 1199.9 6618.9 6708.5 6719.4 6721.1 6721.4 520.7 521.8 533.4 537.3 686.9 4965.8 5022.2 5074.9 5084.1 5092.3 8129.8 8500.9 8595.3 8605.6 8607.9 8419.8 8483.6 8498.3 8535.6 8536.9 6232.6 6495.6 6500.8 6700.3 6743.3 6537.8 6576.0 6584.0 6584.7 6589.4 7203.8 7361.3 7383.8 7447.0 7488.4 7657.0 7788.8 8166.7 8265.7 8274.7 6185.0 6201.3 6245.5 6252.0 6264.9 6885.3 6988.5 6995.5 6996.9 6999.1 6259.6 6273.7 6361.8 6375.1 6409.4 4839.6 6179.0 6267.0 6271.2 6435.1 6217.3 6296.8 6297.4 6307.7 6312.0 5868.8 5896.1 5898.5 5905.4 5916.2 5877.2 5883.5 5892.0 5926.9 5934.5 04:05:05 INFO - 2015-12-11 04:05:05,421 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,421 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4511.49 Median:5231.25 stddev:1325.84 (25.3%) stddev-sans-first:1291.49 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: Values: 308.9 316.2 319.8 322.0 322.7 5106.9 5290.8 5301.5 5323.3 5328.0 5144.2 5207.6 5212.1 5221.2 5241.3 3800.2 3900.4 3929.6 4038.0 4041.2 4020.3 4028.8 4037.3 4040.0 4042.0 3996.7 3999.1 4001.5 4001.6 4005.7 3781.3 3875.1 3880.7 3966.5 3968.6 3489.9 3496.4 3497.3 3508.6 3509.5 4937.9 4943.7 4944.3 4948.7 4951.9 4581.3 4585.2 4589.7 4591.3 4593.6 5309.5 5380.2 5409.6 5418.8 5430.0 3824.4 3827.7 3829.6 3830.0 3830.8 5621.4 5703.2 5709.1 5709.2 5712.7 3931.5 3933.0 3938.4 3942.4 3944.2 3649.8 3717.1 3997.3 3999.3 4005.2 4343.3 4453.5 4455.7 4459.6 4483.8 5391.7 5436.6 5460.6 5468.1 5473.3 1392.1 1413.9 1414.4 1416.4 1416.8 946.5 965.4 965.5 978.2 982.0 4815.6 4835.2 4837.6 4838.0 4845.9 5618.2 5623.1 5629.5 5633.1 5639.3 4817.9 4822.7 4825.1 4825.5 4827.3 2864.9 2916.3 2998.2 3005.5 3019.9 5416.6 5432.3 5437.9 5450.4 5451.4 5797.4 5813.1 5816.6 5819.0 5827.0 5311.5 5431.7 5432.7 5436.1 5440.1 5659.2 5677.0 5677.4 5682.9 5683.1 5558.7 5560.2 5560.2 5565.4 5572.5 5433.5 5439.0 5441.7 5448.3 5450.8 3785.2 3929.1 3936.5 3966.2 3970.4 5564.5 5568.1 5568.6 5569.2 5569.8 5361.9 5370.7 5371.7 5372.2 5372.7 5363.4 5372.4 5374.2 5377.7 5381.8 5134.6 5255.6 5263.2 5267.0 5267.4 5391.5 5391.9 5410.1 5410.9 5414.6 5260.9 5261.2 5266.8 5274.5 5276.5 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11911.65 Median:41882.90 stddev:13127.51 (31.3%) stddev-sans-first:13137.63 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: Values: 762.0 780.1 794.4 800.9 803.1 13091.3 13375.7 13394.9 13398.5 13411.5 12146.2 12165.3 12280.5 12286.9 12314.8 645.8 646.4 651.0 816.9 833.5 638.2 646.1 647.9 812.7 827.7 861.2 865.1 869.6 870.5 870.9 668.7 863.4 863.6 864.3 866.7 497.5 628.5 635.8 638.0 638.0 12301.5 12425.1 12446.8 12458.3 12468.1 10548.3 10630.7 10740.7 11420.9 11551.5 9051.7 9198.7 9204.5 9408.3 9438.2 3184.2 3212.0 3237.1 3269.7 3328.4 38840.8 38894.4 39232.8 39248.2 39439.8 9034.5 9161.9 9191.9 9260.9 9369.3 16115.1 16130.7 16181.6 16199.9 16216.4 6269.0 6315.5 6345.8 6357.0 6577.9 3453.5 3454.7 3500.8 3518.7 3532.7 2764.3 2768.3 2770.9 2771.3 2794.4 471.5 480.1 487.1 490.9 491.9 281.9 441.0 446.9 476.0 525.5 7063.4 7246.1 7281.5 7335.4 7402.3 376.5 384.6 449.0 498.7 552.9 3137.3 3271.1 3469.0 3505.2 3610.7 46943.0 47522.3 47756.5 47818.5 48118.0 40792.8 41111.6 41840.0 41925.8 41939.4 38883.4 38975.2 39048.0 39538.6 39747.2 7462.6 7635.4 7664.7 7790.8 7795.6 29182.0 29473.4 29682.9 29785.1 29851.1 36093.0 36189.6 37413.3 38089.8 38240.6 9685.2 9707.4 10162.1 10232.9 10235.3 10710.4 10973.3 10997.2 11158.5 11289.4 10697.4 10745.8 10806.3 10845.9 10876.5 9717.5 10268.8 10485.5 10799.1 10824.5 8774.5 9074.8 9955.3 10252.9 10681.8 8875.4 8996.3 9368.3 9557.5 10072.1 9300.9 9311.7 9431.5 9511.9 9513.7 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:05:05 INFO - 2015-12-11 04:05:05,422 DEBUG : BROWSER_OUTPUT: 04:05:06 INFO - 2015-12-11 04:05:06,224 INFO : Browser exited with error code: 0 04:05:06 INFO - 2015-12-11 04:05:06,240 INFO : Completed test dromaeo_css (00:18:37) 04:05:06 INFO - 2015-12-11 04:05:06,240 INFO : Starting test kraken 04:05:06 INFO - 2015-12-11 04:05:06,240 DEBUG : operating with platform_type : linux_ 04:05:06 INFO - 2015-12-11 04:05:06,240 INFO : Initialising browser for kraken test... 04:05:06 INFO - 2015-12-11 04:05:06,246 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22uUlh/profile http://localhost:41521/getInfo.html 04:05:10 INFO - 2015-12-11 04:05:10,709 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:05:10 INFO - 2015-12-11 04:05:10,710 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:05:10 INFO - 2015-12-11 04:05:10,710 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:05:10 INFO - 2015-12-11 04:05:10,710 DEBUG : BROWSER_OUTPUT: __metrics 04:05:10 INFO - 2015-12-11 04:05:10,786 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:05:10 INFO - 2015-12-11 04:05:10,854 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] 04:05:10 ERROR - 2015-12-11 04:05:10,870 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:05:11 INFO - 2015-12-11 04:05:11,716 INFO : Browser initialized. 04:05:11 INFO - 2015-12-11 04:05:11,717 INFO : Running cycle 1/1 for kraken test... 04:05:11 INFO - 2015-12-11 04:05:11,717 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp22uUlh/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:05:23 INFO - 2015-12-11 04:05:23,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 142479360 04:05:23 INFO - 2015-12-11 04:05:23,705 DEBUG : BROWSER_OUTPUT: 04:05:26 INFO - 2015-12-11 04:05:26,328 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41521/tests/kraken/driver.html?testName=audio-beat-detection) 04:05:26 INFO - 2015-12-11 04:05:26,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 178053120 04:05:26 INFO - 2015-12-11 04:05:26,910 DEBUG : BROWSER_OUTPUT: 04:05:29 INFO - 2015-12-11 04:05:29,620 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41521/tests/kraken/driver.html?testName=audio-dft) 04:05:30 INFO - 2015-12-11 04:05:30,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 165949440 04:05:30 INFO - 2015-12-11 04:05:30,203 DEBUG : BROWSER_OUTPUT: 04:05:33 INFO - 2015-12-11 04:05:33,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41521/tests/kraken/driver.html?testName=audio-fft) 04:05:33 INFO - 2015-12-11 04:05:33,791 DEBUG : BROWSER_OUTPUT: RSS: Main: 154853376 04:05:33 INFO - 2015-12-11 04:05:33,791 DEBUG : BROWSER_OUTPUT: 04:05:35 INFO - 2015-12-11 04:05:35,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41521/tests/kraken/driver.html?testName=audio-oscillator) 04:05:36 INFO - 2015-12-11 04:05:36,413 DEBUG : BROWSER_OUTPUT: RSS: Main: 157470720 04:05:36 INFO - 2015-12-11 04:05:36,413 DEBUG : BROWSER_OUTPUT: 04:05:38 INFO - 2015-12-11 04:05:38,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41521/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:05:39 INFO - 2015-12-11 04:05:39,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 157093888 04:05:39 INFO - 2015-12-11 04:05:39,240 DEBUG : BROWSER_OUTPUT: 04:05:42 INFO - 2015-12-11 04:05:42,214 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41521/tests/kraken/driver.html?testName=imaging-darkroom) 04:05:42 INFO - 2015-12-11 04:05:42,795 DEBUG : BROWSER_OUTPUT: RSS: Main: 159346688 04:05:42 INFO - 2015-12-11 04:05:42,795 DEBUG : BROWSER_OUTPUT: 04:05:46 INFO - 2015-12-11 04:05:46,163 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41521/tests/kraken/driver.html?testName=imaging-desaturate) 04:05:46 INFO - 2015-12-11 04:05:46,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 159277056 04:05:46 INFO - 2015-12-11 04:05:46,744 DEBUG : BROWSER_OUTPUT: 04:05:49 INFO - 2015-12-11 04:05:49,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41521/tests/kraken/driver.html?testName=json-parse-financial) 04:05:50 INFO - 2015-12-11 04:05:50,178 DEBUG : BROWSER_OUTPUT: RSS: Main: 159059968 04:05:50 INFO - 2015-12-11 04:05:50,178 DEBUG : BROWSER_OUTPUT: 04:05:51 INFO - 2015-12-11 04:05:51,968 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41521/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:05:52 INFO - 2015-12-11 04:05:52,534 DEBUG : BROWSER_OUTPUT: RSS: Main: 167993344 04:05:52 INFO - 2015-12-11 04:05:52,534 DEBUG : BROWSER_OUTPUT: 04:05:54 INFO - 2015-12-11 04:05:54,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:05:54 INFO - 2015-12-11 04:05:54,997 DEBUG : BROWSER_OUTPUT: RSS: Main: 166506496 04:05:54 INFO - 2015-12-11 04:05:54,997 DEBUG : BROWSER_OUTPUT: 04:05:57 INFO - 2015-12-11 04:05:57,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:05:57 INFO - 2015-12-11 04:05:57,721 DEBUG : BROWSER_OUTPUT: RSS: Main: 177811456 04:05:57 INFO - 2015-12-11 04:05:57,721 DEBUG : BROWSER_OUTPUT: 04:06:00 INFO - 2015-12-11 04:06:00,241 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:06:00 INFO - 2015-12-11 04:06:00,822 DEBUG : BROWSER_OUTPUT: RSS: Main: 183713792 04:06:00 INFO - 2015-12-11 04:06:00,822 DEBUG : BROWSER_OUTPUT: 04:06:03 INFO - 2015-12-11 04:06:03,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:06:04 INFO - 2015-12-11 04:06:04,030 DEBUG : BROWSER_OUTPUT: RSS: Main: 180998144 04:06:04 INFO - 2015-12-11 04:06:04,030 DEBUG : BROWSER_OUTPUT: 04:06:05 INFO - 2015-12-11 04:06:05,785 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41521/tests/kraken/driver.html?testName=ai-astar) 04:06:06 INFO - 2015-12-11 04:06:06,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 238120960 04:06:06 INFO - 2015-12-11 04:06:06,044 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,044 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:06 INFO - 2015-12-11 04:06:06,044 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:06 INFO - 2015-12-11 04:06:06,045 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:06 INFO - 2015-12-11 04:06:06,045 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:06 INFO - 2015-12-11 04:06:06,045 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;112;111;112;103;112;113;103 04:06:06 INFO - 2015-12-11 04:06:06,045 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;149;128;149;169;138;152;149;137;172;130 04:06:06 INFO - 2015-12-11 04:06:06,046 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;161;163;164;163;160;162;162;161;161 04:06:06 INFO - 2015-12-11 04:06:06,046 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;86;96;71;74;74;103;91;74 04:06:06 INFO - 2015-12-11 04:06:06,046 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;132;95;95;95;130;96;97;128 04:06:06 INFO - 2015-12-11 04:06:06,046 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;110;110;109;109;109;110;110;109 04:06:06 INFO - 2015-12-11 04:06:06,046 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;147;147;147;146;148;146;149;146 04:06:06 INFO - 2015-12-11 04:06:06,047 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;95;96;96;96;95;95;95;96 04:06:06 INFO - 2015-12-11 04:06:06,047 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;74;72;72;72;73;72;81;70;70 04:06:06 INFO - 2015-12-11 04:06:06,047 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;69;69;68;68;68;67;68 04:06:06 INFO - 2015-12-11 04:06:06,047 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;84;84;84;84;83;83;86;84;83 04:06:06 INFO - 2015-12-11 04:06:06,048 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;120;119;120;123;126;120;120;123;126 04:06:06 INFO - 2015-12-11 04:06:06,048 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;153;158;147;147;146;148;151;146;135 04:06:06 INFO - 2015-12-11 04:06:06,048 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;71;68;68;68;68;68;70;68;70 04:06:06 INFO - 2015-12-11 04:06:06,048 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:06 INFO - 2015-12-11 04:06:06,048 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:06 INFO - 2015-12-11 04:06:06,049 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 04:06:06 INFO - 2015-12-11 04:06:06,049 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:06 INFO - 2015-12-11 04:06:06,049 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835566039__endTimestamp 04:06:06 INFO - 2015-12-11 04:06:06,049 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,051 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:06 INFO - 2015-12-11 04:06:06,051 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:06:06 INFO - 2015-12-11 04:06:06,051 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,051 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:112.00 stddev:3.89 (3.5%) stddev-sans-first:4.12 04:06:06 INFO - 2015-12-11 04:06:06,051 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 112.0 111.0 112.0 103.0 112.0 113.0 103.0 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.30 Median:149.00 stddev:14.82 (9.9%) stddev-sans-first:15.70 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: Values: 149.0 128.0 149.0 169.0 138.0 152.0 149.0 137.0 172.0 130.0 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.90 Median:162.00 stddev:1.20 (0.7%) stddev-sans-first:1.27 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: Values: 162.0 161.0 163.0 164.0 163.0 160.0 162.0 162.0 161.0 161.0 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,052 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.50 Median:74.00 stddev:11.58 (15.6%) stddev-sans-first:11.86 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 86.0 96.0 71.0 74.0 74.0 103.0 91.0 74.0 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.90 Median:95.00 stddev:16.67 (17.5%) stddev-sans-first:17.21 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 132.0 95.0 95.0 95.0 130.0 96.0 97.0 128.0 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,053 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 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,053 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.90 Median:147.00 stddev:0.99 (0.7%) stddev-sans-first:1.05 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 147.0 147.0 147.0 146.0 148.0 146.0 149.0 146.0 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.60 Median:96.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 95.0 96.0 96.0 96.0 95.0 95.0 95.0 96.0 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.80 Median:72.00 stddev:3.12 (4.3%) stddev-sans-first:3.30 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: Values: 72.0 74.0 72.0 72.0 72.0 73.0 72.0 81.0 70.0 70.0 04:06:06 INFO - 2015-12-11 04:06:06,054 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.00 stddev:0.63 (0.9%) stddev-sans-first:0.67 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 69.0 69.0 68.0 68.0 68.0 67.0 68.0 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.50 Median:84.00 stddev:1.51 (1.8%) stddev-sans-first:0.93 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: Values: 80.0 84.0 84.0 84.0 84.0 83.0 83.0 86.0 84.0 83.0 04:06:06 INFO - 2015-12-11 04:06:06,055 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,056 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:123.00 stddev:3.03 (2.5%) stddev-sans-first:2.71 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: Values: 127.0 120.0 119.0 120.0 123.0 126.0 120.0 120.0 123.0 126.0 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.70 Median:147.50 stddev:6.99 (4.7%) stddev-sans-first:6.25 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: Values: 136.0 153.0 158.0 147.0 147.0 146.0 148.0 151.0 146.0 135.0 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:68.00 stddev:1.26 (1.9%) stddev-sans-first:1.20 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: Values: 67.0 71.0 68.0 68.0 68.0 68.0 68.0 70.0 68.0 70.0 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:06 INFO - 2015-12-11 04:06:06,057 DEBUG : BROWSER_OUTPUT: 04:06:06 INFO - 2015-12-11 04:06:06,944 INFO : Browser exited with error code: 0 04:06:06 INFO - 2015-12-11 04:06:06,993 INFO : Completed test kraken (00:01:00) 04:06:06 INFO - 2015-12-11 04:06:06,993 INFO : Starting test v8_7 04:06:06 INFO - 2015-12-11 04:06:06,993 DEBUG : operating with platform_type : linux_ 04:06:06 INFO - 2015-12-11 04:06:06,993 INFO : Initialising browser for v8_7 test... 04:06:07 INFO - 2015-12-11 04:06:07,000 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHnmUbb/profile http://localhost:41521/getInfo.html 04:06:11 INFO - 2015-12-11 04:06:11,144 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:06:11 INFO - 2015-12-11 04:06:11,145 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:06:11 INFO - 2015-12-11 04:06:11,145 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:06:11 INFO - 2015-12-11 04:06:11,145 DEBUG : BROWSER_OUTPUT: __metrics 04:06:11 INFO - 2015-12-11 04:06:11,269 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:06:11 INFO - 2015-12-11 04:06:11,338 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] 04:06:12 INFO - 2015-12-11 04:06:12,420 INFO : Browser initialized. 04:06:12 INFO - 2015-12-11 04:06:12,420 INFO : Running cycle 1/1 for v8_7 test... 04:06:12 INFO - 2015-12-11 04:06:12,420 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHnmUbb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:06:24 INFO - 2015-12-11 04:06:24,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 142675968 04:06:24 INFO - 2015-12-11 04:06:24,412 DEBUG : BROWSER_OUTPUT: 04:06:45 INFO - 2015-12-11 04:06:45,795 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41521/tests/v8_7/run.html (next: http://localhost:41521/tests/v8_7/run.html) 04:06:46 INFO - 2015-12-11 04:06:46,053 DEBUG : BROWSER_OUTPUT: RSS: Main: 439988224 04:06:46 INFO - 2015-12-11 04:06:46,053 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,053 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: |0;Richards;165.92002654720426 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.9508319312021 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.70680044593087 04:06:46 INFO - 2015-12-11 04:06:46,054 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5191.709844559586 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |5;Earley;799.3605115907275 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |6;Boyer;11904.761904761905 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |7;RegExp;26815.78947368421 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |8;Splay;613.9279169211973 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:06:46 INFO - 2015-12-11 04:06:46,055 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: __startTimestamp1449835606047__endTimestamp 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.92 Median:165.92 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: Values: 165.9 04:06:46 INFO - 2015-12-11 04:06:46,056 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.95 Median:186.95 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: Values: 187.0 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.71 Median:278.71 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: Values: 278.7 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,057 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5191.71 Median:5191.71 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: Values: 5191.7 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: Values: 1984.1 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:799.36 Median:799.36 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,058 DEBUG : BROWSER_OUTPUT: Values: 799.4 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11904.76 Median:11904.76 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: Values: 11904.8 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26815.79 Median:26815.79 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: Values: 26815.8 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.93 Median:613.93 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: Values: 613.9 04:06:46 INFO - 2015-12-11 04:06:46,059 DEBUG : BROWSER_OUTPUT: 04:06:46 INFO - 2015-12-11 04:06:46,060 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:06:46 INFO - 2015-12-11 04:06:46,060 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:06:46 INFO - 2015-12-11 04:06:46,060 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:46 INFO - 2015-12-11 04:06:46,060 DEBUG : BROWSER_OUTPUT: 04:06:47 INFO - 2015-12-11 04:06:47,024 INFO : Browser exited with error code: 0 04:06:47 INFO - 2015-12-11 04:06:47,036 INFO : Completed test v8_7 (00:00:40) 04:06:47 INFO - 2015-12-11 04:06:47,092 INFO : Completed test suite (00:20:18) 04:06:47 INFO - 2015-12-11 04:06:47,092 DEBUG : Working with test: dromaeo_css 04:06:47 INFO - 2015-12-11 04:06:47,092 DEBUG : Generating results file: dromaeo_css 04:06:47 INFO - 2015-12-11 04:06:47,094 DEBUG : Working with test: kraken 04:06:47 INFO - 2015-12-11 04:06:47,094 DEBUG : Generating results file: kraken 04:06:47 INFO - 2015-12-11 04:06:47,094 INFO : javascript benchmark 04:06:47 INFO - 2015-12-11 04:06:47,094 DEBUG : Working with test: v8_7 04:06:47 INFO - 2015-12-11 04:06:47,094 DEBUG : Generating results file: v8_7 04:06:47 INFO - 2015-12-11 04:06:47,095 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:47 INFO - 2015-12-11 04:06:47,151 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:06:47 INFO - 2015-12-11 04:06:47,152 DEBUG : process_Request line: dromaeo_css 6200.42 graph.html#tests=[[72,94,35]] 04:06:47 INFO - 2015-12-11 04:06:47,152 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:47 INFO - 2015-12-11 04:06:47,184 DEBUG : process_Request line: kraken 1520.20 graph.html#tests=[[232,94,35]] 04:06:47 INFO - 2015-12-11 04:06:47,184 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:06:47 INFO - 2015-12-11 04:06:47,220 DEBUG : process_Request line: v8_7 19794.82 graph.html#tests=[[230,94,35]] 04:06:47 INFO - 2015-12-11 04:06:47,221 INFO : javascript benchmark 04:06:47 INFO - 2015-12-11 04:06:47,225 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2602.7527384898435, 2696.7303269673034, 2698.8650567471623, 2715.511207982562, 2727.345437095097, 4480.955190448095, 4598.0344127733215, 4654.3716598259225, 4682.601978831799, 4689.390379250697, 4544.9091018179615, 4582.427196600425, 4585.358049873021, 4591.563801438858, 4611.7924693388795, 4261.318189089746, 4324.394584758136, 4340.696151269412, 4385.386045953569, 4391.714538554999, 4377.365282034103, 4378.1462614790125, 4386.204025395373, 4452.10957808438, 4452.599266066053, 4177.6866734995, 4273.465816772903, 4400.647948164139, 4436.4676238851225, 4444.577765112309, 4217.367394890791, 4233.280342341809, 4243.0, 4247.469066366704, 4249.107687385653, 4248.596383343577, 4258.510271318807, 4263.275243208662, 4265.744055356658, 4273.572642735733, 4474.664400170001, 4556.635469162459, 4565.2467342888385, 4590.472095708969, 4597.080583883237, 4989.301497790312, 4991.351124353847, 4993.550580447741, 4999.275105109738, 5034.748262586892, 4795.352627395292, 4902.65681402302, 5015.673981191248, 5020.2720605511995, 5029.572486338666, 4521.480029796583, 4620.653450991189, 4692.319613656069, 4697.013627138339, 4732.195526760459, 5067.594592432597, 5108.080545501845, 5108.591312694975, 5113.948860511422, 5168.095583272912, 4776.9761151194025, 4883.4628190898975, 4921.409430868247, 4928.408590969035, 4940.160172770566, 4853.611711063107, 4913.0, 4930.334404855299, 4939.234418665113, 4984.352034235526, 4929.507049295042, 4991.301217829507, 4992.151334273182, 5011.523905228997, 5026.4973502649445, 4731.787069581877, 4843.15244832153, 4956.3804524434445, 4973.42805577356, 5017.724025178577, 4047.4131250969035, 4076.7146299759324, 4087.448194493705, 4103.938440923389, 4141.585841415835, 3601.5678118625933, 3605.94591081134, 3626.8911932642063, 3650.7809531428197, 3657.6159503252306, 4135.545090040093, 4248.129133527619, 4337.913241735211, 4340.197063543192, 4356.4336636237085, 4834.854954351375, 4895.33912921751, 4907.190313598217, 4928.433230178503, 4945.010997800382, 4291.098869237433, 4337.15425492026, 4349.217140914666, 4379.167958087953, 4391.626711729475, 4206.831726730958, 4316.676249281317, 4451.755153466591, 4461.531539188339, 4461.7992190351515, 4684.906301873943, 4798.49615790344, 4856.417229932289, 4880.585150262267, 4921.876953076202, 5002.924956125734, 5006.774695138654, 5032.949670503248, 5039.596832253337, 5075.644704870623, 4575.7483338416705, 4678.204705200193, 4817.662763606514, 4837.032593481388, 4872.707637541759, 4798.808047678054, 4851.660383773102, 4861.586765125004, 4879.926801098058, 4917.754112294299, 4991.176455884738, 5004.174311238605, 5008.974955125201, 5023.874403139805, 5035.446100928822, 4631.930521042254, 4735.550122738335, 4804.399450068741, 4850.5149485052625, 4890.070886531547, 4709.882252943704, 4780.569748722632, 4792.976035119802, 4800.255960326155, 4802.471728109836, 4663.044075964352, 4666.929996049994, 4670.416197975253, 4701.529847015271, 4715.3869996900185, 4746.596539294061, 4798.592119669867, 4804.639652026042, 4814.879628009187, 4836.153673107263, 4709.81160753566, 4737.976310118427, 4756.6908150970075, 4758.16732071893, 4792.496787837366], "unit": "ms", "name": "dojo.html", "value": 4558.9210009164835}, {"lowerIsBetter": false, "replicates": [560.327606871754, 571.225988785196, 575.0884847516687, 579.0070029898723, 580.4717706886734, 26731.331716707093, 35555.28889422213, 36176.0, 36238.2752344953, 36256.274874502495, 39463.80268098663, 39912.0, 39938.40092398609, 39999.20001599966, 40009.59990400095, 6879.587224766505, 6978.8953165702305, 7887.408444366681, 8061.395395345343, 8072.273495385414, 10077.949610251939, 10324.638637647684, 10338.0, 10346.637867674634, 10355.11981481575, 10009.499525023755, 10074.34516756412, 10106.747331316703, 10107.888132305441, 10109.545070471846, 7004.544704594211, 7103.928960710378, 7104.43164546835, 9995.95002024989, 10165.085142337226, 9819.263555233387, 9938.652147174886, 9951.701448956543, 9954.601815927354, 9963.601455941754, 37215.441768373494, 37632.43551346732, 37638.62361376378, 37645.0, 37660.24679506422, 2852.942941141186, 2877.3813630069426, 2893.3056066544086, 3056.037348235321, 3346.9330613387597, 28539.57190642142, 28719.856400718072, 28746.425071498452, 28793.0, 29087.0, 3374.139594403436, 3394.2023624448234, 3394.4738565522384, 3464.2378676691087, 3474.2183008823067, 216166.0, 216491.0, 216728.0, 216891.0, 217704.99999999843, 44296.114077718266, 45239.321410178876, 53183.20225196625, 53615.73192134014, 53625.0, 56539.71730141405, 57894.94735368568, 58334.4166558329, 58388.4161158383, 58428.12357814636, 13050.347482625832, 13164.539241126515, 13236.404361803741, 13277.004224682994, 13310.0, 9543.522823858919, 9558.661787349776, 9582.089701478348, 9641.27690423207, 9687.321887467951, 17808.554786130193, 18166.455006349832, 18272.451826445227, 18285.908570457064, 18359.806612570406, 7235.237676408238, 7385.852282954311, 7404.629768511553, 7516.210797866254, 7599.4680372373405, 777.809436688015, 789.632820738348, 882.0958517519593, 905.3526728389234, 923.9882328849899, 25953.870230648725, 26142.582273419972, 26276.343091422485, 26406.339841503734, 26543.0, 893.8882639670041, 909.8544232922833, 1037.2946396450336, 1040.0119886108228, 1087.543231842628, 13761.4541309858, 13828.819649806423, 13921.164730116225, 13936.930315348562, 14014.789778153336, 344594.0, 347997.0, 348050.0, 348708.0, 348791.0, 39273.607263927566, 43194.352084718754, 43518.34722479165, 43657.781711091244, 43758.34362484565, 1038.345842119475, 1177.1877404590634, 1194.599809063956, 1196.7008247938015, 1271.841019872516, 23348.416289592897, 23586.646200307354, 23619.763802361755, 24009.399765005317, 24055.158069467485, 32082.358352832347, 32562.837185813918, 35868.282634346644, 36653.0, 36674.8166259167, 315970.08358997066, 319437.0, 321470.0, 321736.0, 322076.0, 26965.494485716732, 27334.1799746, 27348.863255683595, 27398.72601273962, 27413.725862741117, 37563.0, 38155.618443815205, 38426.807865960494, 38530.0, 38837.80581097076, 31261.8436907814, 32599.0, 33317.16707082342, 33611.3277734439, 33827.66172338245, 27470.450590987668, 27493.725062749116, 27579.448411031266, 27824.72175278302, 27983.720162798927, 31964.360712786078, 32223.516647250777, 32344.676553234167, 32601.673983259865, 32684.673153268162, 28968.7103128966, 29181.7081829179, 29794.70205297919, 29887.252818679706, 29907.850460747555, 22897.0, 23233.419164521023, 23341.88329058344, 24170.51658966846, 25312.0], "unit": "ms", "name": "ext.html", "value": 16974.602877934376}, {"lowerIsBetter": false, "replicates": [336.2551947436428, 338.8695352289371, 340.19883175122584, 340.50966608084354, 341.2169071979806, 12413.193142445734, 12778.744425111492, 14683.559493215207, 14930.477433289838, 16418.014919104848, 11727.706807329821, 12735.872641273607, 13517.32413379332, 14669.339879705412, 14698.706025879475, 4708.270218116198, 4962.379702537183, 4969.329140566014, 4970.776315065813, 4971.0, 3654.1960768630993, 3761.0221342450886, 4879.024195160964, 4919.655624106314, 4941.283513890484, 5499.285092937933, 5628.662280263176, 5655.971720141414, 5656.575756818234, 5670.404607516213, 5494.725263736817, 5635.549156067505, 5650.180723795047, 5669.489745922846, 5675.120356344773, 5000.949990500085, 5002.699838009731, 5005.3242812220615, 5005.449400565934, 5007.273945277951, 18960.0, 19484.123214455383, 19692.113854876567, 19755.604887902304, 19789.10949007284, 1867.421099459172, 1879.1731638079339, 1884.1615481110912, 1898.136347961688, 1931.951701207467, 12783.424745886457, 12911.741765164645, 13092.214467132002, 13127.737445251138, 13201.669958251025, 1676.2373120230388, 1686.0766561640041, 1782.3138091834608, 1793.5874748807717, 1796.91015449227, 50167.74916125396, 51402.7429862852, 52145.2178217327, 53419.0, 54628.72685636586, 8386.580670966427, 8826.117388261122, 9513.143817056498, 9527.28545359087, 9539.379940303857, 12265.69335766613, 12269.202501837352, 12286.447109880077, 12293.508259669692, 12314.753704925852, 6374.330695277022, 6377.5216858735785, 6420.454261387741, 6503.772367967098, 6572.901406478906, 6018.187544681412, 6058.242719660043, 6059.909101363483, 6074.301455332605, 6119.816405507842, 3856.82644281008, 3964.207158568298, 3991.261616600938, 4074.246264441088, 4243.6605071594195, 1603.4708546179966, 1645.2267434305857, 1663.8835281530178, 1717.519094653499, 1719.6904557179828, 813.8046868751456, 817.852786498436, 819.0908092017855, 853.2235665544449, 951.690700522333, 15382.230888455533, 15536.300866461037, 15658.217089145497, 15731.528054158394, 16102.838971610368, 710.4884483172108, 801.8997625296838, 857.4298091768903, 881.5415983688446, 925.3337596930199, 8278.710245141512, 8425.36809739272, 8436.957815211008, 8584.141585841366, 8618.138186181332, 461300.0, 469140.0, 470412.0, 470671.0, 477235.0, 65746.67126664432, 67617.0, 68010.0, 68252.31747682558, 69457.3054269461, 1028.4497793680496, 1032.2464600841429, 1051.8895515970867, 1057.735566108473, 1062.4846949229773, 13122.803157952829, 13370.665733356744, 13391.598252052454, 13409.32953352348, 13645.0, 30329.69670303269, 30388.544171837, 31186.376272474878, 31269.374612507167, 31395.372092557565, 41384.58615413807, 41706.0, 44285.557144428145, 44382.77808610936, 44420.55579444164, 8943.418677785923, 9013.098690130935, 9034.819303614022, 9093.727188184364, 9188.816223675356, 15945.601359966093, 16398.508044758677, 16524.173791310146, 16620.750688739437, 16643.75034374461, 13450.663733406744, 13640.727185456037, 13676.794848077088, 14095.473658174622, 14232.146071235758, 12852.421641026363, 12860.228386296852, 13631.727365452438, 13931.58205253844, 13987.930060349634, 10987.780244394908, 13951.23268220217, 14079.788803168165, 14246.0, 14276.21480818565, 8440.957795210985, 8679.26226270774, 8763.518006509448, 8766.254868336262, 8781.25359344463, 9268.72193834186, 9901.950490247502, 13480.393382297623, 13579.185248885098, 13732.519361822688], "unit": "ms", "name": "jquery.html", "value": 8154.31166414937}, {"lowerIsBetter": false, "replicates": [680.826389270736, 1611.911344876032, 1649.200137933103, 1683.5370273174876, 1760.2430954689482, 5777.82666520004, 6735.8989615155815, 6829.897551536725, 6832.760853370133, 6848.383645471907, 6676.833079173023, 6822.59064456133, 6832.0, 6848.486363522743, 6860.0, 2069.855110142287, 2106.9367918962457, 2114.587655407196, 2119.173522326294, 2121.1091341636475, 1922.327185485076, 1922.7404300419473, 1934.6614342490009, 1953.6092781443697, 1962.9705554416696, 1910.6751852185162, 1914.6745053340965, 1939.5442071113278, 1941.3981665683684, 1943.1644392911044, 1979.8020197980159, 2004.5790384019374, 2008.2970960163973, 2009.859309848311, 2014.29499675114, 2043.5708501214763, 2049.8565100442975, 2063.1953538120147, 2084.937451876431, 2087.812096911285, 6781.762638307636, 6860.485463590201, 6863.039174515572, 6875.690593923286, 6883.070785444002, 4113.629773320416, 4170.979145104286, 4182.874513764592, 4184.623383895434, 4190.266703326936, 2619.3320703220747, 2631.3421644588852, 2668.6263923050788, 2745.0666773296975, 2748.038186634682, 839.1692224697566, 843.28320927212, 855.6575379946795, 864.0754392799707, 873.3362644390309, 9427.717168484956, 9551.1403973642, 9558.617655293849, 9609.183219426357, 9633.614655413776, 3793.468914351993, 3808.2383523295453, 3860.0735823402183, 3872.593377695358, 3875.9612403876163, 8399.37004724648, 8419.368547358972, 8430.662773488992, 8433.072362040171, 8437.535935523605, 4142.047329114321, 4188.979055104705, 4189.099343641132, 4190.20386126635, 4196.853110141131, 3222.516622506596, 3273.3289675616916, 3739.121306492972, 3788.8673896413493, 3811.0, 3448.74134439918, 3469.7224222062678, 3473.4616134499192, 3479.2171761353493, 3498.9475157872653, 1076.4563895233014, 1093.8359246112987, 1094.950727217277, 1099.367863478503, 1102.8511150994673, 817.448222449844, 847.8261956298944, 911.290202888227, 979.2117345536769, 1199.8680145184023, 6618.933810661832, 6708.530402871752, 6719.361660642231, 6721.092652491949, 6721.361470660279, 520.6901893373437, 521.7991073436755, 533.3519773475247, 537.2746791830997, 686.9210040845267, 4965.776540055706, 5022.2466630005065, 5074.949250507448, 5084.110280700863, 5092.28707980883, 8129.756107316672, 8500.914990850013, 8595.269402100892, 8605.612747426381, 8607.913920860836, 8419.831603367898, 8483.557795174835, 8498.277646400125, 8535.615897284637, 8536.8719469208, 6232.56372053961, 6495.577787443895, 6500.837479062967, 6700.296468870796, 6743.325667433218, 6537.771178008938, 6576.046473261446, 6583.967080164569, 6584.670766461562, 6589.439897608565, 7203.783886483414, 7361.2638736125955, 7383.815404614713, 7446.962765186356, 7488.400927925862, 7656.961715191388, 7788.844223115392, 8166.6733330668485, 8265.710700125466, 8274.669013239403, 6185.0, 6201.348858369986, 6245.469135123565, 6252.0, 6264.874702506016, 6885.311468853075, 6988.475864310299, 6995.545289556163, 6996.895046574407, 6999.09011828459, 6259.561830671809, 6273.749050037947, 6361.809145725636, 6375.139356186855, 6409.359064093554, 4839.588634966068, 6179.0, 6266.968665156827, 6271.153394291712, 6435.06691529735, 6217.253929528486, 6296.811095667137, 6297.370262973666, 6307.653079080695, 6311.96844015777, 5868.765249390148, 5896.115582662635, 5898.469137777621, 5905.350411454822, 5916.230889984275, 5877.177195192762, 5883.529317654663, 5892.0, 5926.851828704317, 5934.525237981037], "unit": "ms", "name": "mootools.html", "value": 3949.21795067671}, {"lowerIsBetter": false, "replicates": [308.8918878392563, 316.18739838614755, 319.7569846916343, 322.0467416447316, 322.73535700725387, 5106.872328191797, 5290.841274761754, 5301.5228629423345, 5323.254744335796, 5327.973360133194, 5144.202648589475, 5207.609429292808, 5212.061828870802, 5221.190715439113, 5241.3186285782895, 3800.182960663457, 3900.4344370066324, 3929.5873933236885, 4037.97981010096, 4041.1513582147636, 4020.3165461871404, 4028.81870315835, 4037.333839916425, 4040.0, 4041.959580404188, 3996.6802655787615, 3999.060220848098, 4001.539822920358, 4001.5798341174195, 4005.719599628027, 3781.300459415017, 3875.1280961783655, 3880.708946828999, 3966.5240171179353, 3968.583298753647, 3489.91275218119, 3496.4056110461283, 3497.3005398920063, 3508.5965114011706, 3509.491123787062, 4937.851864444073, 4943.6539442239055, 4944.283078953532, 4948.713334533011, 4951.90096198074, 4581.266997280452, 4585.220512512881, 4589.655775816827, 4591.311303304497, 4593.63250939924, 5309.523217350235, 5380.166074258496, 5409.594280428944, 5418.810341638024, 5429.972850135763, 3824.368979118442, 3827.7129215308687, 3829.617038296148, 3829.9808500957597, 3830.808459577038, 5621.353544342412, 5703.173039909231, 5709.143628455723, 5709.229254050691, 5712.742926568314, 3931.4692516510477, 3932.9606703932595, 3938.428927805452, 3942.42834788954, 3944.15200731844, 3649.7773245962367, 3717.1078941054493, 3997.260506806192, 3999.320115580358, 4005.1989602079702, 4343.348497725303, 4453.532379100213, 4455.6658250631335, 4459.620932220732, 4483.843065492692, 5391.676499410048, 5436.592255580847, 5460.563154947595, 5468.125099984063, 5473.31583552056, 1392.1438315435935, 1413.8656827601362, 1414.370605080729, 1416.369715476603, 1416.7591509443419, 946.536197263336, 965.358036905464, 965.5365424596233, 978.1685567267907, 981.9901800982042, 4815.614750819926, 4835.202191638411, 4837.612990960714, 4838.03239352131, 4845.927311090337, 5618.157276408571, 5623.10030395143, 5629.549636029108, 5633.0987042073075, 5639.2668953035845, 4817.940053188293, 4822.662413631082, 4825.059113472839, 4825.5174482551465, 4827.300041494034, 2864.9283767905968, 2916.2709322669334, 2998.190488568074, 3005.4740420426338, 3019.879204831826, 5416.593755468356, 5432.293801805819, 5437.945620543823, 5450.400455949843, 5451.373092094381, 5797.391273916178, 5813.128030795415, 5816.621919575214, 5819.010768169422, 5827.038538641162, 5311.548518375981, 5431.6740995540395, 5432.701201433959, 5436.075867102523, 5440.102383106743, 5659.236003139524, 5677.0, 5677.375488696158, 5682.886342273214, 5683.090705487102, 5558.694271815089, 5560.165975103767, 5560.221568980265, 5565.415631358649, 5572.526335261386, 5433.538149257357, 5438.972805135949, 5441.673499590037, 5448.264484294569, 5450.754716037867, 3785.2240290739783, 3929.0766669833138, 3936.488256526633, 3966.206758648224, 3970.4441378206498, 5564.4713752193475, 5568.136938774334, 5568.582356323373, 5569.248151499496, 5569.805056822992, 5361.946380536145, 5370.677759334452, 5371.650842695212, 5372.221027950847, 5372.677639341652, 5363.383210930793, 5372.409035006224, 5374.167004114369, 5377.650452720561, 5381.811636592701, 5134.589232861287, 5255.605829562722, 5263.23683065961, 5267.0256002639635, 5267.420583735862, 5391.541718953933, 5391.9460805391445, 5410.1343784994215, 5410.945890541044, 5414.593905457028, 5260.921086183634, 5261.210818377274, 5266.815661451831, 5274.472552744694, 5276.525112739719], "unit": "ms", "name": "prototype.html", "value": 4094.1531923459465}, {"lowerIsBetter": false, "replicates": [761.9504732192407, 780.127693535515, 794.447858738177, 800.9359251259896, 803.120582961657, 13091.279979601119, 13375.665608359795, 13394.933025334873, 13398.464061437531, 13411.46354145833, 12146.210496317755, 12165.270083794978, 12280.508779648804, 12286.93856530716, 12314.753704925895, 645.7642960319497, 646.4020780777785, 650.9739610415578, 816.9428140030216, 833.4665813879122, 638.2054342343765, 646.1245013007377, 647.8866198415259, 812.7196117339508, 827.6606591297569, 861.2378045429808, 865.1219012702112, 869.613022205119, 870.5386145342978, 870.8911386076741, 668.6890595872942, 863.3611127765471, 863.5811631358786, 864.3215076165211, 866.6836604639325, 497.46274024053935, 628.5003422279253, 635.7933671556763, 637.968101594923, 638.0238235499646, 12301.507939682491, 12425.130240883142, 12446.751064978649, 12458.252504849737, 12468.127231093828, 10548.31435956668, 10630.681079567625, 10740.677779666623, 11420.942895285554, 11551.53793848245, 9051.683191088347, 9198.67804626835, 9204.539773011322, 9408.341416100875, 9438.244940404751, 3184.1561986073707, 3211.951820722691, 3237.14215732831, 3269.722073623745, 3328.3842489139342, 38840.80579597112, 38894.41658375126, 39232.80383598092, 39248.215035699126, 39439.8028009861, 9034.503102329303, 9161.862572061424, 9191.862122068174, 9260.907390926004, 9369.344145909858, 16115.113668748098, 16130.677386452206, 16181.59546011359, 16199.919000404923, 16216.351345946267, 6268.968655156695, 6315.463185629181, 6345.841353966188, 6356.968215158895, 6577.934220657828, 3453.533772940671, 3454.654534546525, 3500.8272228803635, 3518.7009104226427, 3532.699720523733, 2764.3089227693076, 2768.2525718056413, 2770.9307267318077, 2771.3210263485576, 2794.3712664650293, 471.48608017261347, 480.0926249388658, 487.0721275969284, 490.92636104584597, 491.9483454237325, 281.91542537238746, 440.99559004410185, 446.8681738887036, 475.9857204283877, 525.5296509623865, 7063.434925205971, 7246.109613477721, 7281.526700764433, 7335.376492998155, 7402.29678180572, 376.47293788696044, 384.6480470369581, 448.97857374473335, 498.6933036182721, 552.850730302824, 3137.341158356725, 3271.1004473769904, 3469.0, 3505.2288496530723, 3610.7472476926887, 46943.0, 47522.28716569254, 47756.5224347759, 47818.52181478141, 48118.0, 40792.79603602023, 41111.58888411077, 41840.0, 41925.79037104795, 41939.37090943638, 38883.416748748794, 38975.220495590496, 39048.0, 39538.604613953496, 39747.20505589872, 7462.626868656654, 7635.350995165473, 7664.655090520829, 7790.766277011699, 7795.64919578609, 29182.0, 29473.410531789672, 29682.851585741933, 29785.10644680663, 29851.10446686603, 36093.0, 36189.63810361968, 37413.2517349646, 38089.809550952064, 38240.61759382371, 9685.176759975198, 9707.417554946725, 10162.085412312927, 10232.948835256075, 10235.334703244265, 10710.357378557312, 10973.286736362112, 10997.230193886671, 11158.497867595815, 11289.435528223392, 10697.358158510515, 10745.838812417976, 10806.297590656897, 10845.945770271099, 10876.51055702511, 9717.465539395402, 10268.845967310346, 10485.52815123306, 10799.13606911461, 10824.5128969195, 8774.473531588124, 9074.773130671787, 9955.253355998473, 10252.897471025195, 10681.839772403575, 8875.423097498642, 8996.325275604226, 9368.344215905094, 9557.52212389364, 10072.093511583993, 9300.906990930003, 9311.72064838056, 9431.528423578931, 9511.904880951102, 9513.714588562354], "unit": "ms", "name": "yui.html", "value": 5568.733128521683}], "name": "dromaeo_css", "value": 6200.424313440263}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 112.0, 111.0, 112.0, 103.0, 112.0, 113.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [149.0, 128.0, 149.0, 169.0, 138.0, 152.0, 149.0, 137.0, 172.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.3}, {"lowerIsBetter": true, "replicates": [162.0, 161.0, 163.0, 164.0, 163.0, 160.0, 162.0, 162.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.9}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 86.0, 96.0, 71.0, 74.0, 74.0, 103.0, 91.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 81.5}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 132.0, 95.0, 95.0, 95.0, 130.0, 96.0, 97.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.9}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 148.0, 146.0, 149.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.9}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 95.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.6}, {"lowerIsBetter": true, "replicates": [72.0, 74.0, 72.0, 72.0, 72.0, 73.0, 72.0, 81.0, 70.0, 70.0], "unit": "ms", "name": "json-parse-financial", "value": 72.8}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 68.0, 67.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [80.0, 84.0, 84.0, 84.0, 84.0, 83.0, 83.0, 86.0, 84.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.5}, {"lowerIsBetter": true, "replicates": [127.0, 120.0, 119.0, 120.0, 123.0, 126.0, 120.0, 120.0, 123.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [136.0, 153.0, 158.0, 147.0, 147.0, 146.0, 148.0, 151.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.7}, {"lowerIsBetter": true, "replicates": [67.0, 71.0, 68.0, 68.0, 68.0, 68.0, 68.0, 70.0, 68.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1520.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.92002654720426], "unit": "score", "name": "Richards", "value": 212.765154}, {"lowerIsBetter": false, "replicates": [186.9508319312021], "unit": "score", "name": "DeltaBlue", "value": 353.66518199999996}, {"lowerIsBetter": false, "replicates": [278.70680044593087], "unit": "score", "name": "Encrypt", "value": 955.0574279999998}, {"lowerIsBetter": false, "replicates": [5191.709844559586], "unit": "score", "name": "Decrypt", "value": 51.270392215568904}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [799.3605115907275], "unit": "score", "name": "Earley", "value": 833.7452129999997}, {"lowerIsBetter": false, "replicates": [11904.761904761905], "unit": "score", "name": "Boyer", "value": 55.98289200000003}, {"lowerIsBetter": false, "replicates": [26815.78947368421], "unit": "score", "name": "RegExp", "value": 33.97196270853777}, {"lowerIsBetter": false, "replicates": [613.9279169211973], "unit": "score", "name": "Splay", "value": 132.73708159203986}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19794.81896382841}]} 04:06:47 INFO - RETURN: dromaeo_css: 6200.42 04:06:47 INFO - RETURN: kraken: 1520.20 04:06:47 INFO - RETURN: v8_7: 19794.82 04:06:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19794.82"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1520.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6200.42"}}} 04:06:47 INFO - Return code: 0 04:06:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:06:47 ERROR - # TBPL SUCCESS # 04:06:47 INFO - Running post-action listener: _resource_record_post_action 04:06:47 INFO - Running post-run listener: _resource_record_post_run 04:06:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 506859520; Read time: 8; Write time: 396208 04:06:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 232067072; Read time: 0; Write time: 218828 04:06:48 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274792448; Read time: 8; Write time: 177380 04:06:48 INFO - Running post-run listener: _upload_blobber_files 04:06:48 INFO - Blob upload gear active. 04:06:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:06:48 INFO - Copying logs to upload dir... 04:06:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1282.096855 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 22 secs) (at 2015-12-11 04:06:47.629933) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-11 04:06:47.635183) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010009 build_url: 'https://queue.taskcluster.net/v1/task/92Hv94vGQOewZq5tqGSJig/artifacts/public/build/firefox-45.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-11 04:06:47.691848) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:06:47.692225) ========= 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=cbaddfaace6f82c7d20be4ba000001bb-1449827992.411433-566311409 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004546 ========= master_lag: 0.08 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-11 04:06:47.773106) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:06:47.773503) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-11 04:06:47.773854) ========= ========= Total master_lag: 0.30 =========