builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-015 starttime: 1449490524.36 results: success (0) buildid: 20151207025331 builduid: a99e38f3e38a461c83651fd9de849d22 revision: 528ea05671e9bd9ccb33d1558a20691a72c85f98 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.357666) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.358350) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.358702) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005508 basedir: '/builds/slave/test' ========= master_lag: 0.05 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.416887) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.417212) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.511355) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.511683) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021764 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.563876) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.564229) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.564650) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.564975) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 04:15:24-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 227M=0s 2015-12-07 04:15:25 (227 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.254995 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.835759) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.836370) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.130246 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.984223) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:24.984914) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 528ea05671e9bd9ccb33d1558a20691a72c85f98 --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 528ea05671e9bd9ccb33d1558a20691a72c85f98 --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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 04:15:25,236 truncating revision to first 12 chars 2015-12-07 04:15:25,236 Setting DEBUG logging. 2015-12-07 04:15:25,236 attempt 1/10 2015-12-07 04:15:25,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/528ea05671e9?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-07 04:15:25,483 unpacking tar archive at: mozilla-central-528ea05671e9/testing/mozharness/ program finished with exit code 0 elapsedTime=0.567973 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:25.571276) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:25.571982) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:25.582192) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:25.582520) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 04:15:25.583010) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-07 04:15:25.583416) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:15:26 INFO - MultiFileLogger online at 20151207 04:15:26 in /builds/slave/test 04:15:26 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 04:15:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:15:26 INFO - {'append_to_log': False, 04:15:26 INFO - 'base_work_dir': '/builds/slave/test', 04:15:26 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:15:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:15:26 INFO - 'branch': 'Firefox-Non-PGO', 04:15:26 INFO - 'buildbot_json_path': 'buildprops.json', 04:15:26 INFO - 'config_files': ('talos/linux_config.py',), 04:15:26 INFO - 'default_actions': ('clobber', 04:15:26 INFO - 'read-buildbot-config', 04:15:26 INFO - 'download-and-extract', 04:15:26 INFO - 'populate-webroot', 04:15:26 INFO - 'create-virtualenv', 04:15:26 INFO - 'install', 04:15:26 INFO - 'run-tests'), 04:15:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:15:26 INFO - 'download_minidump_stackwalk': True, 04:15:26 INFO - 'download_symbols': 'ondemand', 04:15:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:15:26 INFO - 'tooltool.py': '/tools/tooltool.py', 04:15:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:15:26 INFO - '/tools/misc-python/virtualenv.py')}, 04:15:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:15:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:15:26 INFO - 'installer_path': 'installer.exe', 04:15:26 INFO - 'log_level': 'info', 04:15:26 INFO - 'log_name': 'talos', 04:15:26 INFO - 'log_to_console': True, 04:15:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:15:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:15:26 INFO - 'opt_config_files': (), 04:15:26 INFO - 'pip_index': False, 04:15:26 INFO - 'sps_profile': False, 04:15:26 INFO - 'sps_profile_interval': 0, 04:15:26 INFO - 'suite': 'dromaeojs-e10s', 04:15:26 INFO - 'system_bits': '64', 04:15:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:15:26 INFO - 'title': 'talos-linux64-ix-015', 04:15:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:15:26 INFO - 'use_talos_json': True, 04:15:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:15:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:15:26 INFO - 'work_dir': 'build'} 04:15:26 INFO - ##### 04:15:26 INFO - ##### Running clobber step. 04:15:26 INFO - ##### 04:15:26 INFO - Running pre-action listener: _resource_record_pre_action 04:15:26 INFO - Running main action method: clobber 04:15:26 INFO - rmtree: /builds/slave/test/build 04:15:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:15:30 INFO - Running post-action listener: _resource_record_post_action 04:15:30 INFO - ##### 04:15:30 INFO - ##### Running read-buildbot-config step. 04:15:30 INFO - ##### 04:15:30 INFO - Running pre-action listener: _resource_record_pre_action 04:15:30 INFO - Running main action method: read_buildbot_config 04:15:30 INFO - Using buildbot properties: 04:15:30 INFO - { 04:15:30 INFO - "properties": { 04:15:30 INFO - "buildnumber": 135, 04:15:30 INFO - "product": "firefox", 04:15:30 INFO - "script_repo_revision": "production", 04:15:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 04:15:30 INFO - "repository": "", 04:15:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 04:15:30 INFO - "buildid": "20151207025331", 04:15:30 INFO - "slavename": "talos-linux64-ix-015", 04:15:30 INFO - "pgo_build": "False", 04:15:30 INFO - "basedir": "/builds/slave/test", 04:15:30 INFO - "project": "", 04:15:30 INFO - "platform": "ubuntu64_hw", 04:15:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:15:30 INFO - "slavebuilddir": "test", 04:15:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:15:30 INFO - "branch": "mozilla-central", 04:15:30 INFO - "repo_path": "mozilla-central", 04:15:30 INFO - "stage_platform": "linux64", 04:15:30 INFO - "builduid": "a99e38f3e38a461c83651fd9de849d22", 04:15:30 INFO - "revision": "528ea05671e9bd9ccb33d1558a20691a72c85f98" 04:15:30 INFO - }, 04:15:30 INFO - "sourcestamp": { 04:15:30 INFO - "repository": "", 04:15:30 INFO - "hasPatch": false, 04:15:30 INFO - "project": "", 04:15:30 INFO - "branch": "mozilla-central-linux64-talos", 04:15:30 INFO - "changes": [ 04:15:30 INFO - { 04:15:30 INFO - "category": null, 04:15:30 INFO - "files": [ 04:15:30 INFO - { 04:15:30 INFO - "url": null, 04:15:30 INFO - "name": "https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:15:30 INFO - } 04:15:30 INFO - ], 04:15:30 INFO - "repository": "", 04:15:30 INFO - "rev": "528ea05671e9bd9ccb33d1558a20691a72c85f98", 04:15:30 INFO - "who": "cbook@mozilla.com", 04:15:30 INFO - "when": 1449490440, 04:15:30 INFO - "number": 6953980, 04:15:30 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:15:30 INFO - "project": "", 04:15:30 INFO - "at": "Mon 07 Dec 2015 04:14:00", 04:15:30 INFO - "branch": "mozilla-central-linux64-talos", 04:15:30 INFO - "revlink": "", 04:15:30 INFO - "properties": [ 04:15:30 INFO - [ 04:15:30 INFO - "buildid", 04:15:30 INFO - "20151207025331", 04:15:30 INFO - "Change" 04:15:30 INFO - ], 04:15:30 INFO - [ 04:15:30 INFO - "builduid", 04:15:30 INFO - "a99e38f3e38a461c83651fd9de849d22", 04:15:30 INFO - "Change" 04:15:30 INFO - ], 04:15:30 INFO - [ 04:15:30 INFO - "pgo_build", 04:15:30 INFO - "False", 04:15:30 INFO - "Change" 04:15:30 INFO - ] 04:15:30 INFO - ], 04:15:30 INFO - "revision": "528ea05671e9bd9ccb33d1558a20691a72c85f98" 04:15:30 INFO - } 04:15:30 INFO - ], 04:15:30 INFO - "revision": "528ea05671e9bd9ccb33d1558a20691a72c85f98" 04:15:30 INFO - } 04:15:30 INFO - } 04:15:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:15:30 INFO - Running post-action listener: _resource_record_post_action 04:15:30 INFO - ##### 04:15:30 INFO - ##### Running download-and-extract step. 04:15:30 INFO - ##### 04:15:30 INFO - Running pre-action listener: _resource_record_pre_action 04:15:30 INFO - Running main action method: download_and_extract 04:15:30 INFO - mkdir: /builds/slave/test/build/tests 04:15:30 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')]} 04:15:30 INFO - https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:15:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/test_packages.json 04:15:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/test_packages.json 04:15:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:15:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:15:35 INFO - Downloaded 1302 bytes. 04:15:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:15:35 INFO - Using the following test package requirements: 04:15:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:15:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'jsshell-linux-x86_64.zip'], 04:15:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:15:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:15:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:15:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:15:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:15:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:15:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:15:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:15: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')]} 04:15:35 INFO - https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:42 INFO - Downloaded 21849481 bytes. 04:15:42 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 04:15:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:42 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 04:15:43 INFO - Return code: 0 04:15:43 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 04:15:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:43 INFO - https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:15:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:47 INFO - Downloaded 21849481 bytes. 04:15:47 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 04:15:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:15:47 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 04:15:48 INFO - Return code: 0 04:15: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')]} 04:15:48 INFO - https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:15:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:50 INFO - Downloaded 11132001 bytes. 04:15:50 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 04:15:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:15:50 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 04:15:50 INFO - Return code: 0 04:15:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:50 INFO - https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:15:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:15:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:15:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/cS5qahOKSkCvE6pQjy5WVw/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 04:15:52 INFO - Downloaded 57703970 bytes. 04:15:52 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:15:52 INFO - mkdir: /builds/slave/test/properties 04:15:52 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:15:52 INFO - Writing to file /builds/slave/test/properties/build_url 04:15:52 INFO - Contents: 04:15:52 INFO - build_url:https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:15:52 INFO - Running post-action listener: _resource_record_post_action 04:15:52 INFO - Running post-action listener: set_extra_try_arguments 04:15:52 INFO - ##### 04:15:52 INFO - ##### Running populate-webroot step. 04:15:52 INFO - ##### 04:15:52 INFO - Running pre-action listener: _resource_record_pre_action 04:15:52 INFO - Running main action method: populate_webroot 04:15:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:15:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:15:52 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 04:15:52 INFO - '../fennec_ids.txt'], 04:15:52 INFO - 'tests': ['tcheck2']}, 04:15:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:15:52 INFO - '--tppagecycles', 04:15:52 INFO - '7'], 04:15:52 INFO - 'tests': ['tsvgm']}}, 04:15:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:15:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:15:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:15:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:15:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:15:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'tests': ['damp', 'tps']}, 04:15:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['damp', 'tps']}, 04:15:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:15:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:15:52 INFO - 'other': {'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'other_l64': {'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'other_nol64': {'tests': ['a11yr', 04:15:52 INFO - 'ts_paint', 04:15:52 INFO - 'tpaint', 04:15:52 INFO - 'sessionrestore', 04:15:52 INFO - 'sessionrestore_no_auto_restore']}, 04:15:52 INFO - 'svgr': {'tests': ['tsvgx', 04:15:52 INFO - 'tsvgr_opacity', 04:15:52 INFO - 'tart', 04:15:52 INFO - 'tscrollx', 04:15:52 INFO - 'cart']}, 04:15:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['tsvgx', 04:15:52 INFO - 'tsvgr_opacity', 04:15:52 INFO - 'tart', 04:15:52 INFO - 'tscrollx', 04:15:52 INFO - 'cart']}, 04:15:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'tests': ['tp5o']}, 04:15:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'talos_options': ['--e10s'], 04:15:52 INFO - 'tests': ['tp5o']}, 04:15:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'talos_options': ['--xperf_path', 04:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:52 INFO - 'tests': ['tp5n']}, 04:15:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:15:52 INFO - 'talos_options': ['--e10s', 04:15:52 INFO - '--xperf_path', 04:15:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:15:52 INFO - 'tests': ['tp5n']}}, 04:15:52 INFO - 'talos.zip': {'path': '', 04:15:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:15:52 INFO - Running post-action listener: _resource_record_post_action 04:15:52 INFO - ##### 04:15:52 INFO - ##### Running create-virtualenv step. 04:15:52 INFO - ##### 04:15:52 INFO - Running pre-action listener: _resource_record_pre_action 04:15:52 INFO - Running main action method: create_virtualenv 04:15:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:15:52 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 04:15:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:15:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:15:52 INFO - Using real prefix '/usr' 04:15:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:15:52 INFO - Installing distribute.............................................................................................................................................................................................done. 04:15:54 INFO - Installing pip.................done. 04:15:54 INFO - Return code: 0 04:15:54 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:15:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:15:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:15:54 INFO - Using env: {'DISPLAY': ':0', 04:15:54 INFO - 'HOME': '/home/cltbld', 04:15:54 INFO - 'LANG': 'en_US.UTF-8', 04:15:54 INFO - 'LANGUAGE': 'en_US:en', 04:15:54 INFO - 'LOGNAME': 'cltbld', 04:15:54 INFO - 'MAIL': '/var/mail/cltbld', 04:15:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:54 INFO - 'MOZ_NO_REMOTE': '1', 04:15:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:54 INFO - 'NO_EM_RESTART': '1', 04:15:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:54 INFO - 'PWD': '/builds/slave/test', 04:15:54 INFO - 'SHELL': '/bin/bash', 04:15:54 INFO - 'SHLVL': '1', 04:15:54 INFO - 'TERM': 'linux', 04:15:54 INFO - 'TMOUT': '86400', 04:15:54 INFO - 'USER': 'cltbld', 04:15:54 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:15:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:54 INFO - '_': '/tools/buildbot/bin/python'} 04:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:55 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 04:15:55 INFO - Cleaning up... 04:15:55 INFO - Return code: 0 04:15:55 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:15: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')]} 04:15:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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')]} 04:15:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15: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', '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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:15: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', 'psutil>=0.7.1'] in /builds/slave/test/build 04:15: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 psutil>=0.7.1 04:15:55 INFO - Using env: {'DISPLAY': ':0', 04:15:55 INFO - 'HOME': '/home/cltbld', 04:15:55 INFO - 'LANG': 'en_US.UTF-8', 04:15:55 INFO - 'LANGUAGE': 'en_US:en', 04:15:55 INFO - 'LOGNAME': 'cltbld', 04:15:55 INFO - 'MAIL': '/var/mail/cltbld', 04:15:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:55 INFO - 'MOZ_NO_REMOTE': '1', 04:15:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:55 INFO - 'NO_EM_RESTART': '1', 04:15:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:55 INFO - 'PWD': '/builds/slave/test', 04:15:55 INFO - 'SHELL': '/bin/bash', 04:15:55 INFO - 'SHLVL': '1', 04:15:55 INFO - 'TERM': 'linux', 04:15:55 INFO - 'TMOUT': '86400', 04:15:55 INFO - 'USER': 'cltbld', 04:15:55 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:15:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:55 INFO - '_': '/tools/buildbot/bin/python'} 04:15:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:55 INFO - Downloading/unpacking psutil>=0.7.1 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15: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 04:15:56 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:15:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:15:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:15:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:57 INFO - Installing collected packages: psutil 04:15:57 INFO - Running setup.py install for psutil 04:15:57 INFO - building 'psutil._psutil_linux' extension 04:15:57 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 04:15:58 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 04:15:58 INFO - building 'psutil._psutil_posix' extension 04:15:58 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 04:15:58 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 04:15:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:15:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:15:58 INFO - Successfully installed psutil 04:15:58 INFO - Cleaning up... 04:15:58 INFO - Return code: 0 04:15:58 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:15:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:15:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:15:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:15:58 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:15:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:15:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:15:58 INFO - Using env: {'DISPLAY': ':0', 04:15:58 INFO - 'HOME': '/home/cltbld', 04:15:58 INFO - 'LANG': 'en_US.UTF-8', 04:15:58 INFO - 'LANGUAGE': 'en_US:en', 04:15:58 INFO - 'LOGNAME': 'cltbld', 04:15:58 INFO - 'MAIL': '/var/mail/cltbld', 04:15:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:15:58 INFO - 'MOZ_NO_REMOTE': '1', 04:15:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:15:58 INFO - 'NO_EM_RESTART': '1', 04:15:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:15:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:15:58 INFO - 'PWD': '/builds/slave/test', 04:15:58 INFO - 'SHELL': '/bin/bash', 04:15:58 INFO - 'SHLVL': '1', 04:15:58 INFO - 'TERM': 'linux', 04:15:58 INFO - 'TMOUT': '86400', 04:15:58 INFO - 'USER': 'cltbld', 04:15:58 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:15:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:15:58 INFO - '_': '/tools/buildbot/bin/python'} 04:15:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:15:58 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:15:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:15:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:15:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:00 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:16:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:16:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:16:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:16:00 INFO - Installing collected packages: mozsystemmonitor 04:16:00 INFO - Running setup.py install for mozsystemmonitor 04:16:00 INFO - Successfully installed mozsystemmonitor 04:16:00 INFO - Cleaning up... 04:16:01 INFO - Return code: 0 04:16:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:01 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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16:01 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 04:16:01 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 04:16:01 INFO - Using env: {'DISPLAY': ':0', 04:16:01 INFO - 'HOME': '/home/cltbld', 04:16:01 INFO - 'LANG': 'en_US.UTF-8', 04:16:01 INFO - 'LANGUAGE': 'en_US:en', 04:16:01 INFO - 'LOGNAME': 'cltbld', 04:16:01 INFO - 'MAIL': '/var/mail/cltbld', 04:16:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:01 INFO - 'MOZ_NO_REMOTE': '1', 04:16:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:01 INFO - 'NO_EM_RESTART': '1', 04:16:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:01 INFO - 'PWD': '/builds/slave/test', 04:16:01 INFO - 'SHELL': '/bin/bash', 04:16:01 INFO - 'SHLVL': '1', 04:16:01 INFO - 'TERM': 'linux', 04:16:01 INFO - 'TMOUT': '86400', 04:16:01 INFO - 'USER': 'cltbld', 04:16:01 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:01 INFO - '_': '/tools/buildbot/bin/python'} 04:16:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:01 INFO - Downloading/unpacking blobuploader==1.2.4 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:01 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:01 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:03 INFO - Downloading blobuploader-1.2.4.tar.gz 04:16:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:16:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:16:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 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 04:16:03 INFO - Downloading docopt-0.6.1.tar.gz 04:16:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:16:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:16:03 INFO - Installing collected packages: blobuploader, requests, docopt 04:16:03 INFO - Running setup.py install for blobuploader 04:16:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:16:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:16:03 INFO - Running setup.py install for requests 04:16:04 INFO - Running setup.py install for docopt 04:16:04 INFO - Successfully installed blobuploader requests docopt 04:16:04 INFO - Cleaning up... 04:16:04 INFO - Return code: 0 04:16:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:04 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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16:04 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 04:16:04 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 04:16:04 INFO - Using env: {'DISPLAY': ':0', 04:16:04 INFO - 'HOME': '/home/cltbld', 04:16:04 INFO - 'LANG': 'en_US.UTF-8', 04:16:04 INFO - 'LANGUAGE': 'en_US:en', 04:16:04 INFO - 'LOGNAME': 'cltbld', 04:16:04 INFO - 'MAIL': '/var/mail/cltbld', 04:16:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:04 INFO - 'MOZ_NO_REMOTE': '1', 04:16:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:04 INFO - 'NO_EM_RESTART': '1', 04:16:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:04 INFO - 'PWD': '/builds/slave/test', 04:16:04 INFO - 'SHELL': '/bin/bash', 04:16:04 INFO - 'SHLVL': '1', 04:16:04 INFO - 'TERM': 'linux', 04:16:04 INFO - 'TMOUT': '86400', 04:16:04 INFO - 'USER': 'cltbld', 04:16:04 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:04 INFO - '_': '/tools/buildbot/bin/python'} 04:16:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:04 INFO - Running setup.py (path:/tmp/pip-avuH6G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:04 INFO - Running setup.py (path:/tmp/pip-AVCXk4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:04 INFO - Running setup.py (path:/tmp/pip-hVCgUy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:04 INFO - Running setup.py (path:/tmp/pip-6Dk7Om-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:04 INFO - Running setup.py (path:/tmp/pip-gxvcOu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:04 INFO - Running setup.py (path:/tmp/pip-GI3quK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:05 INFO - Running setup.py (path:/tmp/pip-Fqu58N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:05 INFO - Running setup.py (path:/tmp/pip-9BAkil-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:05 INFO - Running setup.py (path:/tmp/pip-74FF0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:05 INFO - Running setup.py (path:/tmp/pip-HMuZNG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:05 INFO - Running setup.py (path:/tmp/pip-T489TA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:05 INFO - Running setup.py (path:/tmp/pip-g7G8S8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:05 INFO - Running setup.py (path:/tmp/pip-fzGfVX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:05 INFO - Running setup.py (path:/tmp/pip-S0xSZ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:05 INFO - Running setup.py (path:/tmp/pip-MO8K5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:05 INFO - Running setup.py (path:/tmp/pip-0DEqvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:05 INFO - Running setup.py (path:/tmp/pip-Z3qYiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:16:05 INFO - Running setup.py install for manifestparser 04:16:05 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:16:05 INFO - Running setup.py install for mozcrash 04:16:06 INFO - Running setup.py install for mozdebug 04:16:06 INFO - Running setup.py install for mozdevice 04:16:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for mozfile 04:16:06 INFO - Running setup.py install for mozhttpd 04:16:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for mozinfo 04:16:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for mozInstall 04:16:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for mozleak 04:16:06 INFO - Running setup.py install for mozlog 04:16:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for moznetwork 04:16:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:16:06 INFO - Running setup.py install for mozprocess 04:16:07 INFO - Running setup.py install for mozprofile 04:16:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:16:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:16:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:16:07 INFO - Running setup.py install for mozrunner 04:16:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:16:07 INFO - Running setup.py install for mozscreenshot 04:16:07 INFO - Running setup.py install for moztest 04:16:07 INFO - Running setup.py install for mozversion 04:16:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:16:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:16:07 INFO - Cleaning up... 04:16:07 INFO - Return code: 0 04:16:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16: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')]} 04:16:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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')]} 04:16:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16: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/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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16: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/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 04:16: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/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 04:16:07 INFO - Using env: {'DISPLAY': ':0', 04:16:07 INFO - 'HOME': '/home/cltbld', 04:16:07 INFO - 'LANG': 'en_US.UTF-8', 04:16:07 INFO - 'LANGUAGE': 'en_US:en', 04:16:07 INFO - 'LOGNAME': 'cltbld', 04:16:07 INFO - 'MAIL': '/var/mail/cltbld', 04:16:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:07 INFO - 'MOZ_NO_REMOTE': '1', 04:16:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:07 INFO - 'NO_EM_RESTART': '1', 04:16:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:07 INFO - 'PWD': '/builds/slave/test', 04:16:07 INFO - 'SHELL': '/bin/bash', 04:16:07 INFO - 'SHLVL': '1', 04:16:07 INFO - 'TERM': 'linux', 04:16:07 INFO - 'TMOUT': '86400', 04:16:07 INFO - 'USER': 'cltbld', 04:16:07 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:07 INFO - '_': '/tools/buildbot/bin/python'} 04:16:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:16:07 INFO - Running setup.py (path:/tmp/pip-0g_iPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:16:07 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)) 04:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:16:07 INFO - Running setup.py (path:/tmp/pip-xEEaat-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:16:07 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)) 04:16:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:16:07 INFO - Running setup.py (path:/tmp/pip-pTum6c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:16:08 INFO - Running setup.py (path:/tmp/pip-1gLRSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:16:08 INFO - Running setup.py (path:/tmp/pip-k4WiIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:16:08 INFO - Running setup.py (path:/tmp/pip-nbXAeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:16:08 INFO - Running setup.py (path:/tmp/pip-Of9iop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:16:08 INFO - Running setup.py (path:/tmp/pip-sMKtSi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:16:08 INFO - Running setup.py (path:/tmp/pip-zGJ7gZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:16:08 INFO - Running setup.py (path:/tmp/pip-q0bIT8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:16:08 INFO - Running setup.py (path:/tmp/pip-9lWgob-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:16:08 INFO - Running setup.py (path:/tmp/pip-jdKIXi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:16:08 INFO - Running setup.py (path:/tmp/pip-ebZ33E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:16:08 INFO - Running setup.py (path:/tmp/pip-EzhWdA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:08 INFO - Running setup.py (path:/tmp/pip-DBh4C3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:16:08 INFO - Running setup.py (path:/tmp/pip-zjuyvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:16:08 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)) 04:16:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:16:08 INFO - Running setup.py (path:/tmp/pip-GMn7ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:16:09 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)) 04:16:09 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)) 04:16:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:16:09 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)) 04:16:09 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)) 04:16:09 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)) 04:16:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:10 INFO - Downloading blessings-1.5.1.tar.gz 04:16:10 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 04:16:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:16:10 INFO - Installing collected packages: blessings 04:16:10 INFO - Running setup.py install for blessings 04:16:10 INFO - Successfully installed blessings 04:16:10 INFO - Cleaning up... 04:16:10 INFO - Return code: 0 04:16:10 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:16:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:11 INFO - Reading from file tmpfile_stdout 04:16:11 INFO - Current package versions: 04:16:11 INFO - argparse == 1.2.1 04:16:11 INFO - blessings == 1.5.1 04:16:11 INFO - blobuploader == 1.2.4 04:16:11 INFO - docopt == 0.6.1 04:16:11 INFO - manifestparser == 1.1 04:16:11 INFO - mozInstall == 1.12 04:16:11 INFO - mozcrash == 0.16 04:16:11 INFO - mozdebug == 0.1 04:16:11 INFO - mozdevice == 0.47 04:16:11 INFO - mozfile == 1.2 04:16:11 INFO - mozhttpd == 0.7 04:16:11 INFO - mozinfo == 0.9 04:16:11 INFO - mozleak == 0.1 04:16:11 INFO - mozlog == 3.1 04:16:11 INFO - moznetwork == 0.27 04:16:11 INFO - mozprocess == 0.22 04:16:11 INFO - mozprofile == 0.27 04:16:11 INFO - mozrunner == 6.11 04:16:11 INFO - mozscreenshot == 0.1 04:16:11 INFO - mozsystemmonitor == 0.0 04:16:11 INFO - moztest == 0.7 04:16:11 INFO - mozversion == 1.4 04:16:11 INFO - psutil == 3.1.1 04:16:11 INFO - requests == 1.2.3 04:16:11 INFO - wsgiref == 0.1.2 04:16:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16:11 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 04:16:11 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 04:16:11 INFO - Using env: {'DISPLAY': ':0', 04:16:11 INFO - 'HOME': '/home/cltbld', 04:16:11 INFO - 'LANG': 'en_US.UTF-8', 04:16:11 INFO - 'LANGUAGE': 'en_US:en', 04:16:11 INFO - 'LOGNAME': 'cltbld', 04:16:11 INFO - 'MAIL': '/var/mail/cltbld', 04:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:11 INFO - 'MOZ_NO_REMOTE': '1', 04:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:11 INFO - 'NO_EM_RESTART': '1', 04:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:11 INFO - 'PWD': '/builds/slave/test', 04:16:11 INFO - 'SHELL': '/bin/bash', 04:16:11 INFO - 'SHLVL': '1', 04:16:11 INFO - 'TERM': 'linux', 04:16:11 INFO - 'TMOUT': '86400', 04:16:11 INFO - 'USER': 'cltbld', 04:16:11 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:11 INFO - '_': '/tools/buildbot/bin/python'} 04:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 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)) 04:16:11 INFO - Cleaning up... 04:16:11 INFO - Return code: 0 04:16:11 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:11 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:16:11 INFO - Using env: {'DISPLAY': ':0', 04:16:11 INFO - 'HOME': '/home/cltbld', 04:16:11 INFO - 'LANG': 'en_US.UTF-8', 04:16:11 INFO - 'LANGUAGE': 'en_US:en', 04:16:11 INFO - 'LOGNAME': 'cltbld', 04:16:11 INFO - 'MAIL': '/var/mail/cltbld', 04:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:11 INFO - 'MOZ_NO_REMOTE': '1', 04:16:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:11 INFO - 'NO_EM_RESTART': '1', 04:16:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:11 INFO - 'PWD': '/builds/slave/test', 04:16:11 INFO - 'SHELL': '/bin/bash', 04:16:11 INFO - 'SHLVL': '1', 04:16:11 INFO - 'TERM': 'linux', 04:16:11 INFO - 'TMOUT': '86400', 04:16:11 INFO - 'USER': 'cltbld', 04:16:11 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:11 INFO - '_': '/tools/buildbot/bin/python'} 04:16:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:11 INFO - Downloading/unpacking jsonschema 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16: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 04:16:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:16:13 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 04:16:13 INFO - Downloading/unpacking functools32 (from jsonschema) 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:13 INFO - Downloading functools32-3.2.3-2.tar.gz 04:16:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 04:16:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:16:13 INFO - warning: no files found matching '*.txt' 04:16:13 INFO - no previously-included directories found matching 'build' 04:16:13 INFO - no previously-included directories found matching 'dist' 04:16:13 INFO - no previously-included directories found matching '.git*' 04:16:13 INFO - Installing collected packages: jsonschema, functools32 04:16:13 INFO - Running setup.py install for functools32 04:16:13 INFO - warning: no files found matching '*.txt' 04:16:13 INFO - no previously-included directories found matching 'build' 04:16:13 INFO - no previously-included directories found matching 'dist' 04:16:13 INFO - no previously-included directories found matching '.git*' 04:16:13 INFO - Successfully installed jsonschema functools32 04:16:13 INFO - Cleaning up... 04:16:13 INFO - Return code: 0 04:16:13 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:16:13 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')]} 04:16:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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')]} 04:16:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:16:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:16:13 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 0x7fda244c3f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x206c8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x213a240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, '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': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', '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 04:16:13 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 04:16:13 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 04:16:13 INFO - Using env: {'DISPLAY': ':0', 04:16:13 INFO - 'HOME': '/home/cltbld', 04:16:13 INFO - 'LANG': 'en_US.UTF-8', 04:16:13 INFO - 'LANGUAGE': 'en_US:en', 04:16:13 INFO - 'LOGNAME': 'cltbld', 04:16:13 INFO - 'MAIL': '/var/mail/cltbld', 04:16:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:13 INFO - 'MOZ_NO_REMOTE': '1', 04:16:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:13 INFO - 'NO_EM_RESTART': '1', 04:16:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:13 INFO - 'PWD': '/builds/slave/test', 04:16:13 INFO - 'SHELL': '/bin/bash', 04:16:13 INFO - 'SHLVL': '1', 04:16:13 INFO - 'TERM': 'linux', 04:16:13 INFO - 'TMOUT': '86400', 04:16:13 INFO - 'USER': 'cltbld', 04:16:13 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:13 INFO - '_': '/tools/buildbot/bin/python'} 04:16:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:16:14 INFO - Downloading/unpacking flake8 04:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:16:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:16:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:16:15 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:16:15 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 04:16:15 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:16:15 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 04:16:15 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:15 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 04:16:16 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 04:16:16 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:16:16 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 04:16:16 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 04:16:16 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 04:16:16 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 04:16:16 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 04:16:16 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 04:16:16 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:16:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:16 INFO - no previously-included directories found matching 'docs/_build' 04:16:16 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:16:16 INFO - Running setup.py install for pep8 04:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:16:16 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:16:16 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:16:16 INFO - no previously-included directories found matching 'docs/_build' 04:16:16 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:16:16 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:16:16 INFO - Cleaning up... 04:16:16 INFO - Return code: 0 04:16:16 INFO - Running post-action listener: _resource_record_post_action 04:16:16 INFO - Running post-action listener: _start_resource_monitoring 04:16:16 INFO - Starting resource monitoring. 04:16:16 INFO - ##### 04:16:16 INFO - ##### Running install step. 04:16:16 INFO - ##### 04:16:16 INFO - Running pre-action listener: _resource_record_pre_action 04:16:16 INFO - Running main action method: install 04:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:16:16 INFO - Reading from file tmpfile_stdout 04:16:16 INFO - Detecting whether we're running mozinstall >=1.0... 04:16:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:16:16 INFO - Reading from file tmpfile_stdout 04:16:16 INFO - Output received: 04:16:16 INFO - Usage: mozinstall [options] installer 04:16:16 INFO - Options: 04:16:16 INFO - -h, --help show this help message and exit 04:16:16 INFO - -d DEST, --destination=DEST 04:16:16 INFO - Directory to install application into. [default: 04:16:16 INFO - "/builds/slave/test"] 04:16:16 INFO - --app=APP Application being installed. [default: firefox] 04:16:16 INFO - mkdir: /builds/slave/test/build/application 04:16:16 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'] 04:16:16 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 04:16:31 INFO - Reading from file tmpfile_stdout 04:16:31 INFO - Output received: 04:16:31 INFO - /builds/slave/test/build/application/firefox/firefox 04:16:31 INFO - Running post-action listener: _resource_record_post_action 04:16:31 INFO - ##### 04:16:31 INFO - ##### Running run-tests step. 04:16:31 INFO - ##### 04:16:31 INFO - Running pre-action listener: _resource_record_pre_action 04:16:31 INFO - Running main action method: run_tests 04:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:16:31 INFO - Python 2.7.3 04:16:31 INFO - Return code: 0 04:16:31 INFO - grabbing minidump binary from tooltool 04:16:31 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')]} 04:16:31 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 0x21c90b0>, '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 0x21c9fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ca440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:16:31 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 04:16:31 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 04:16:31 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:16:31 INFO - Return code: 0 04:16:31 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:16:31 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:16:31 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:16:31 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:16:31 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:16:31 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:16:32 INFO - Return code: 0 04:16:32 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] in /builds/slave/test/build 04:16:32 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-015 --webServer localhost 04:16:32 INFO - Using env: {'DISPLAY': ':0', 04:16:32 INFO - 'HOME': '/home/cltbld', 04:16:32 INFO - 'LANG': 'en_US.UTF-8', 04:16:32 INFO - 'LANGUAGE': 'en_US:en', 04:16:32 INFO - 'LOGNAME': 'cltbld', 04:16:32 INFO - 'MAIL': '/var/mail/cltbld', 04:16:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:16:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:16:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:16:32 INFO - 'MOZ_NO_REMOTE': '1', 04:16:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:16:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:16:32 INFO - 'NO_EM_RESTART': '1', 04:16:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:16:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:16:32 INFO - 'PWD': '/builds/slave/test', 04:16:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:16:32 INFO - 'SHELL': '/bin/bash', 04:16:32 INFO - 'SHLVL': '1', 04:16:32 INFO - 'TERM': 'linux', 04:16:32 INFO - 'TMOUT': '86400', 04:16:32 INFO - 'USER': 'cltbld', 04:16:32 INFO - 'XDG_SESSION_COOKIE': '70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789', 04:16:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:16:32 INFO - '_': '/tools/buildbot/bin/python'} 04:16:32 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-015', '--webServer', 'localhost'] with output_timeout 3600 04:16:32 INFO - mozversion INFO | application_buildid: 20151207025331 04:16:32 INFO - mozversion INFO | application_changeset: 528ea05671e9bd9ccb33d1558a20691a72c85f98 04:16:32 INFO - mozversion INFO | application_display_name: Nightly 04:16:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:16:32 INFO - mozversion INFO | application_name: Firefox 04:16:32 INFO - mozversion INFO | application_remotingname: firefox 04:16:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:16:32 INFO - mozversion INFO | application_vendor: Mozilla 04:16:32 INFO - mozversion INFO | application_version: 45.0a1 04:16:32 INFO - mozversion INFO | platform_buildid: 20151207025331 04:16:32 INFO - mozversion INFO | platform_changeset: 528ea05671e9bd9ccb33d1558a20691a72c85f98 04:16:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:16:32 INFO - mozversion INFO | platform_version: 45.0a1 04:16:32 INFO - 2015-12-07 04:16:32,828 DEBUG : using testdate: 1449490592 04:16:32 INFO - 2015-12-07 04:16:32,829 DEBUG : actual date: 1449490592 04:16:32 INFO - 2015-12-07 04:16:32,876 INFO : starting webserver on 'localhost:50864' 04:16:32 INFO - 2015-12-07 04:16:32,877 INFO : Starting test suite talos-linux64-ix-015.e 04:16:32 INFO - 2015-12-07 04:16:32,877 INFO : Starting test dromaeo_css 04:16:32 INFO - 2015-12-07 04:16:32,878 DEBUG : operating with platform_type : linux_ 04:16:32 INFO - 2015-12-07 04:16:32,878 INFO : Initialising browser for dromaeo_css test... 04:16:32 INFO - 2015-12-07 04:16:32,894 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybEjj_/profile http://localhost:50864/getInfo.html 04:16:39 INFO - 2015-12-07 04:16:39,069 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:16:39 INFO - 2015-12-07 04:16:39,070 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:16:39 INFO - 2015-12-07 04:16:39,070 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:16:39 INFO - 2015-12-07 04:16:39,070 DEBUG : BROWSER_OUTPUT: __metrics 04:16:39 INFO - 2015-12-07 04:16:39,212 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:16:40 INFO - 2015-12-07 04:16:40,162 INFO : Browser initialized. 04:16:40 INFO - 2015-12-07 04:16:40,163 INFO : Running cycle 1/1 for dromaeo_css test... 04:16:40 INFO - 2015-12-07 04:16:40,163 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpybEjj_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:16:52 INFO - 2015-12-07 04:16:52,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 143790080 04:16:52 INFO - 2015-12-07 04:16:52,236 DEBUG : BROWSER_OUTPUT: 04:17:41 INFO - 2015-12-07 04:17:41,888 DEBUG : BROWSER_OUTPUT: 1449490661885 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] 04:19:54 INFO - 2015-12-07 04:19:54,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50864/tests/dromaeo/cssquery-ext.html) 04:19:55 INFO - 2015-12-07 04:19:55,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 147206144 04:19:55 INFO - 2015-12-07 04:19:55,462 DEBUG : BROWSER_OUTPUT: 04:22:57 INFO - 2015-12-07 04:22:57,460 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-ext.html (next: http://localhost:50864/tests/dromaeo/cssquery-jquery.html) 04:22:58 INFO - 2015-12-07 04:22:58,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 147099648 04:22:58 INFO - 2015-12-07 04:22:58,053 DEBUG : BROWSER_OUTPUT: 04:25:59 INFO - 2015-12-07 04:25:59,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50864/tests/dromaeo/cssquery-mootools.html) 04:26:00 INFO - 2015-12-07 04:26:00,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 145600512 04:26:00 INFO - 2015-12-07 04:26:00,439 DEBUG : BROWSER_OUTPUT: 04:29:02 INFO - 2015-12-07 04:29:02,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50864/tests/dromaeo/cssquery-prototype.html) 04:29:02 INFO - 2015-12-07 04:29:02,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 144453632 04:29:02 INFO - 2015-12-07 04:29:02,827 DEBUG : BROWSER_OUTPUT: 04:32:05 INFO - 2015-12-07 04:32:05,390 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50864/tests/dromaeo/cssquery-yui.html) 04:32:06 INFO - 2015-12-07 04:32:06,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 144388096 04:32:06 INFO - 2015-12-07 04:32:06,016 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,212 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/dromaeo/cssquery-yui.html (next: http://localhost:50864/tests/dromaeo/cssquery-dojo.html) 04:35:08 INFO - 2015-12-07 04:35:08,470 DEBUG : BROWSER_OUTPUT: RSS: Main: 147140608 04:35:08 INFO - 2015-12-07 04:35:08,470 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,470 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2581.5998520229364;2627.5401804684197;2659.202239328201;2668.5063263296292;2684.6644169478814;4476.529964353745;4547.113312903985;4644.34979102925;4648.209804333263;4667.69659972102;4535.546445355463;4540.341650460689;4594.218982772928;4621.792019359128;4732.574068333849;4199.2651286024975;4275.786210689469;4283.957160428403;4310.741355518679;4331.263685173512;4377.277749171383;4387.23223435899;4405.8237670493145;4454.175977444167;4480.126375356806;4106.938395924063;4191.476065491814;4220.261454245526;4294.291441912081;4403.977980110111;4307.547707490699;4308.138372325548;4309.288967320388;4333.090051089275;4353.10761293934;4296.591823776736;4304.655627549789;4307.5261721210645;4310.698251122422;4345.06581085065;4426.889327766799;4438.134563760068;4541.227991241464;4631.768411579407;4671.672982891199;5009.624278179152;5063.291139240509;5065.746712664352;5071.518205770446;5093.974530127362;4732.1718699227495;5083.186690129562;5094.821681241176;5102.515261050195;5146.794128234867;4552.954470455253;4613.469451013109;4677.766111694402;4682.859514214579;4715.457722361973;5090.134677104901;5116.948830511647;5120.103981803244;5131.7177555234075;5167.405748338989;4720.504347043511;4841.031793641286;4906;4913.828016019422;4946.431160416598;4927.704337739747;4986.950130498649;5007.4491805901325;5019.247112933089;5055.974720126376;4925.38432695913;4933.925991110136;4938.358013458299;4943.332650092263;4986.675866068694;4736.100140973204;4788.521147885183;4866.975665121652;4938.111139994764;4963.8262660806695;4088.223237584909;4095.1809638072505;4104.52797928242;4107.54816970133;4127.938080928789;3602.6397360264286;3606.783592984429;3617.5478065241846;3633.691136253448;3640.4175331946763;4086.6526345260986;4183.644390226804;4202.201581699467;4303.1393721255245;4305.870823875289;5013.423456302499;5023.974880125576;5025.045241404122;5048.0913435581215;5054;4313.827446902152;4332.610065094093;4333.090051089306;4341.5007274163245;4380.78096095194;4196.958030419718;4260.723053001545;4298.699091063596;4317.201317756162;4350.390945267665;4719.126961512131;4762.833300834454;4803.807847686054;4817.301491283814;4836.153673107192;4822.228443449031;5078.08594453002;5096.847094587169;5102.515261050195;5133.56364708989;4670.4395472542155;4719.433667959729;4719.528047195253;4728.787204575871;4833.250846118857;4902.60779137661;4907.803687852446;4915.7542122893;4924.089043526959;4946.258061290835;4969;4986.276989836526;4988.72562009093;5008.273800299009;5049.924251136309;4542.364069030405;4633.953660463352;4635.768211589474;4646.3727396801;4697.906041879211;4740.194166991689;4800.855974320776;4808.014357056865;4810.350602668595;4852.514748525119;4681.368015317888;4709.081729062937;4726.7636618169645;4729.43246810385;4776.522347765195;4643.767811609338;4721;4749.35883655702;4860.902781944412;4884.780184891617;4715.24556071027;4750.52494750536;4772.570468657837;4773.188557945227;4785.808567657255 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.8685682054673;567.9204911312416;574.3395095640016;593.8990371636821;601.7292218501674;37952.24095518088;38401.119916006304;38544;38590.99999999996;38783.61216387835;40361;40998.38502422466;41049.17901641973;41162.58837411625;41439.792801035954;7894.6052697365185;8073.798155046112;8087.716929907425;8095.271425571697;8115.918840811605;7891.921080789205;7936.880946785803;7946.801329966739;8043.396745244101;8051.2351326623875;7937.880931785999;7961.203879612021;7986.920130798676;7996.120426753053;8021.67913283468;7938.206179382045;7996.960015199916;8014.679412823451;8019;8041.236082572204;7815.8436831263625;7974.401919856034;7994.160613135653;8001.239882211239;8013.278804907528;37413.81293093544;37600.24799503994;37789;37850.432243516094;37976.81011594952;2427.757224277576;2492.700875894886;2493.4514406830467;2493.501299740059;2589.8057645676463;27244.45511089767;27266.863665681543;27292.727072729216;27555.17334479949;28055.43889122206;3214.5017522284083;3220.935581288361;3282.9822754945803;3292.5719656444508;3296.5549650797075;215078;218636;218814;218826.90586547126;219413;47855.76072119617;48591.51408485941;54127.45872541303;54588.18117728158;54646.453535464934;64300.356996430375;65633;66265;66368;66444.33555664479;14412.495562655256;14724.779128313085;14755;14778.187199703905;14797;11226;11281.661550153509;11354.602588909349;11376.033037191932;11464;18464.63070738578;18526.536836579195;18683.719744203576;18748.343807966656;18956.905215473835;7567.810804729926;7944.920550794418;8019.759407217793;8066.878996815052;8071.515709057476;903.5708038681573;932.3659911260272;941.8587211918131;1022.3712416863575;1071.1430855315716;26417.33956651099;26540.46919061608;26738.19785406441;26754.331141721614;26824.463510729674;963.8554216867386;1019.3730855523947;1037.444966942682;1045.5086109528509;1046.6598355534481;14114;14144.71710565783;14161.362738676784;14210.147391156564;14225;204699;208264;208464;208728;209021;46038;46570.76714616405;46976.295355569695;47277.76361118173;47286.52713472821;1196.9281843089443;1226.47874653272;1234.2779474007627;1261.8801213884667;1262.3940508555945;27173;27205.455890882466;27440;27510.449791003666;27922.441551168456;40892;41100.79449602733;41101.588984109774;41115.1776964465;41143.38284925669;247383;250306;250670;250676;251489;28667.28331791722;29359.853200733858;29875.402491950474;29964.250893727833;29985.550216747204;35083;35670.75152369655;35683;35751.82124089363;35801.64198358087;29875;30029.84985075148;30065.3986920256;30297.848510757307;30497.23756906095;29481.262968425963;29727.405451891274;29817.403651926405;30075;30406.84796576003;32457.188570285933;32646.51030234596;33220.66779332176;33388.332233355686;33808.49287260644;29243;29675.703242967294;29963.850180748956;30058.84970575133;30119.698803011688;23194.420139496648;23197;23399.41501462477;23439.88280058589;23736.287911362688 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |2;jquery.html;334.76566403517546;335.20221871944767;335.51685572775204;336.1797214795898;336.34245050925443;10059.849102263472;10136.493175341231;10490.527926243318;14822;15355.846441535596;15688.529344119666;15917.761233581477;16111.113888736145;16113.113778742165;16348.264328105233;5171.09505836479;5253;5486.890262194754;5487.478689524489;5508.898220355944;5450.264214331054;5478.534324582415;5486.204500347447;5490.231367608518;5493.395726470085;3892.4550562921213;4017.6183262590007;5527;5530.695811730353;6351.587146835464;6520.18497687789;6524.706388212542;6528.281888992207;6555.50833687473;6566.080748695186;5992.79025234119;6063.060225665029;6099.085137229406;6102.72537735803;6104.572679912408;19936.601267974704;20699.379018629465;20787.792122078736;22010;22266.443338916495;1705.0792572011098;1711.7774689290436;1772.6011647379237;1868.870259958255;1994.8204661580382;12217.389130543526;12893.806592901114;12899.484020639164;13210.471581136742;13299.800502992462;1716.6909956207878;1727.6285598596237;1736.7308067249596;1742.6166243426426;1747.2574155983657;59186.70406647939;61693.69153154251;62579;63837.68081159611;64196.35803641951;15621.843781562266;15666.764998525032;15688.921555392379;15697.215139242991;15745.606359840867;23160.536789264457;23171.3048608542;23219;23419.180328688755;23491.17780877661;8555.529445880537;8889.64441422336;8908.510031948304;8945.06076861933;9002.369834111549;7470.663820128108;7472.29013243741;7545.698172073166;7583.62081895903;7607.543547387064;7402.592857392788;7534.773956781196;7579.772606821693;7668.622726954662;7732.226777322336;2944.4111177764103;2985.5521671748975;3074.6925307469523;3109.3936682347176;3174.1112488503254;761.3756719489965;767.8272388712495;959.165525992391;962.4946902876046;994.8209322321907;15106.54680359591;15646.452374167076;15652.843471565138;16719.91640041792;17258.654826903392;804.3042768005633;818.2104269380077;840.6973489543759;883.6730409748434;937.3063932689761;8695.478271303742;9041.457512549268;9074.546272686339;9149.81700365989;9467.952660236655;310948;316954;317075;472252;475509;62134;70714.64642676753;75477.24522754812;75882.62058689671;77179.61410192912;997.7777222901888;1020.8979102089731;1032.9225308101923;1037.1858091398217;1038.7662775875367;14483.855161448251;14673.779893301395;14812.555623331318;14813.703725925636;15015.624609384417;32246.516302255954;32642.183945400604;32733.67266327306;33015;34022.82988585041;43882.341764872916;44572.331415029446;44607.776961114985;45868.31197531973;45948.310775339065;8694;8762.29901607857;8809.471431714117;8898.288136948899;8919.73240802777;10108.494575271354;10122.59509619607;10284.691459255935;11410.82883756761;16503.33986640521;10350;10510.632127875488;12642.747145056863;12888;13166.605001849959;11908.583199587973;12215.206011609216;12237.510499580274;12713.745725085631;12773.552925647558;13453.529126480918;13471.461141554228;13664.590062298146;13832.515861945187;13873.098248613807;8749.256313213447;8758.82482350362;8818.867716984121;8839.204471597586;8866.911330886609;9256.352055356061;9289.535523223676;12413.503459861504;13031.218126912416;13062.608121756362 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1506.8794496440287;1646.4319809665667;1699.2608215426283;1710.4783041172445;1728.438257566291;5871.647701137924;6260.280067792205;6812.761553345634;7105.324994125563;7131.322524360177;7036.788896333118;7267.527610705313;7326.560406375608;7328.230535793745;7334.3032411920785;2033.5932813437335;2077.9168833246654;2078.1375729072415;2105.442057854662;2114.4925217947734;2050.9384718458396;2083.6353638113346;2090.4460318015663;2102.0750869617395;2120.3850883243917;2025.5341271507489;2052.692096185569;2073.0982022820044;2080.4174831047253;2081.916723331065;2079.906404211814;2080.043180137131;2095.078165607136;2099.0973881231066;2113.186423227053;2007.046652839904;2020.6463868822898;2059.9588008239903;2062.5256191076137;2082.79172082792;7267.636618169124;7270.454715896276;7274.672639731225;7364.594947277951;7371.189169191384;4198.265303571863;4267.381229721673;4268.359746038088;4272.316429371285;4280.657547396201;2624.317677403889;2658.1095333063445;2689.9596506052426;2692.7172646872186;2710.2004908551826;760.3954855889581;763.4617594595796;768.5196752029981;805.9556724380157;836.0761358698672;9652.22782177424;9686.70939871805;9745.512724363753;9755.951220243924;9940;3883.6893048556612;3930.9803450982563;3950.4469374287623;3992.2414741199077;4001.579834117376;8564.229219370287;8584.270337021424;8612;8619.525926074;8661.913380866237;4349.782510874444;4357.411749413788;4358.5205627380965;4369.344598310279;4419.911601767946;3246.1397729601676;3379.746519011084;3800.8859734208017;3955.3275943089743;3966.8809935701975;3443.9311213776086;3477.5305333779615;3504.9649503505148;3536.9823150884595;3546.4503002034726;1104.100158370925;1114.9331040137617;1118.189312748251;1120.56298043763;1126.2679258482053;920.5167287174287;941.8540126280437;960.3901522533241;969.6509256667593;970.7039352997404;6936.34104760047;6951.7914462566205;6973.79078627642;6993.440524758007;6995.580265184105;416.2216654855379;419.20351332468556;428.98069586868667;434.9956500435018;440.0275391385011;5385.111456609694;5465.07093794048;5465.754041068082;5472.398036216013;5479.397266300703;8055.275025247639;8082.838343233102;8111.148329425443;8147.918520814835;8236.629351679188;8104.635291411901;8136.023677158661;8165.346772258205;8183.590820458953;8196.508209507329;6271.31015588294;6389.648569328639;6426.228852537725;6483.546151769331;6489.610623362613;6841.93158068413;6984.476164287597;6991.161060672752;7005;7011.50919435655;7829.3345065670055;7843.764687059397;7909.05091389037;8012.238837310446;8035.638396272065;8014.559199244098;8089.514629122272;8129.309008734087;8160.795980100545;8213.876791848008;5176.197689358156;5566.610337276514;6064.605800622945;6076.058210977306;6176.876462470816;6910.481713871379;7006.229314775473;7020.613866237406;7049.9647501762165;7058.188308344606;6339.270983836917;6555.541112122106;6623.602583844985;6625.867482650224;6676.298988606321;6297.96851015742;6404.935950640434;6427.58220715652;6588.901166482602;6593.736250549924;6185.350538193605;6218.409251121137;6235.064740288993;6235.127082208403;6252.906206406817;5744.741486633028;5869.911951320648;5871.853203669943;5880.970595146997;5882.352941176553;5889.234399528034;5902.1146827976145;5937.2578427696535;5961.463468287875;5979.551533635082 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |4;prototype.html;280.76976878959255;284.63140233397746;290.078999177611;290.2004976290321;292.3568150069847;5139.614528910337;5428.348598168225;5477.4796394342575;5523.861903452415;5549.4728000839905;5335.253064570963;5394.271773310602;5401.945980540193;5402.6758394496255;5403.918941215885;4073.40935564343;4077.2660921034203;4078.5717499662555;4089.386592011207;4129.938050929223;4078.6125318094882;4080.8367665293354;4083.4487344208596;4090.386442033689;4131.52487463941;3967.642912137907;4027.758334499925;4079.3676980068135;4097.323941549641;4103.035786590149;4031.3348297530874;4032.3145065338963;4037.3338399164104;4055.1484188320487;4082.0611259410207;3492.8777492787885;3495.0563347895927;3498.492718555821;3506.053365591276;3507.631698671654;5112.10538155825;5257.290265814105;5261.76322065508;5263.605229607795;5283.181106928394;4666.673332866701;4680.648951328664;4688.085823264465;4689.788959496796;4702.835400760991;5696.857578560528;5707.1724599933195;5711.485966263056;5718.42815718429;5719.571032172562;3817.4273858921106;3821.312163810513;3824.521934758155;3829.8468061277517;3834.7699138051807;5862.325832529228;5894.263217097863;5912.201852749867;5941.584089113807;6001.909971350433;3864.8260828262796;3901.8634347798256;3902.492675952108;3911.5697273299916;3935.8032098394965;3989.4813674222164;3996.220736956324;4007.4189242559664;4007.499062617173;4010.8195131219163;4576.336431217454;4582.0377720679035;4654.255319148988;4665.183592871234;4665.6734028617675;5389.245505629215;5551.500364967173;5551.722413879371;5648.406917273709;5663;1381.1367895065584;1402.0746307437043;1403.0669604712955;1403.8876889848787;1407.183833376639;905.8369493491235;918.2470374293016;925.3892430995511;927.3693888156118;929.1962452478557;4836.540528649773;4872.43966943806;4937.456879743226;4942.258661200849;4947.826826061142;5794.21778059965;5799.333076696234;5799.5070419014855;5800.1589769484035;5801.3328467225965;4866.075445665383;4919.114559379274;4927.113119638428;4927.507249275044;4940.555350018516;3091.2271932016997;3106.4718997770433;3148.6064241969752;3179.6184457865206;3188.091393952712;5535.612507124462;5603.943960560342;5608.018596745554;5617.269754931833;5623.746931388097;6118.908216376758;6118.908216376758;6123.755049797958;6129.96935015331;6133.355997620186;5582.967151077064;5602.999999999918;5608.383077861432;5610.102383618601;5613.073842815971;5761.942380576141;5965.4929331005615;5969.313528944227;5971.850703732442;5983;5797.797077102281;5838.94161058384;5848.005839007464;5851.590388672752;5852.092925596539;5617.129344951539;5619.538919880779;5631.49316561495;5636.774529018958;5636.88726225465;3832.3293423651307;3882.3205938960004;3910.648041676263;3930.9213815724097;3935.3900145477496;5750.166225897305;5861.560382971209;5938.346781854079;5940.3168635605725;5959.106134079922;5568.55451563882;5635.605507614428;5645.520130788929;5687.8862422752145;5710.885782284248;5633;5641.153826925994;5699.629524080921;5709.400512946247;5720.227769251098;5454.127339625641;5590.888182236414;5591.412901645269;5595.860103497445;5596.1605759136455;5720.799772007959;5757.3954734753925;5769.769209231752;5777.2200752897825;5778.913316300343;5584.218209450762;5594.272744543184;5600.467955544217;5602.13166959122;5609.298837645294 04:35:08 INFO - 2015-12-07 04:35:08,471 DEBUG : BROWSER_OUTPUT: |5;yui.html;766.321805202396;770.3875419041862;779.6062988190963;791.2917938445091;793.6269953122032;11092.556297748091;11365.488553015113;11398.25911315764;11406.657800265984;11420.771584568303;10648.254622176451;11096.778064438706;11279.661610151708;11367.545298188063;11401.771964560725;802.1016461563057;821.7534739578133;821.8726097454904;822.4859462835727;822.9382796290272;811.3468657730524;814.2793627639552;819.1562690428868;819.5328662662284;820.1675299570941;848.8514509960763;851.9701810436636;856.2550580994543;856.4689892266772;861.8017855893148;841.6212704283066;845.2688424512813;850.8255807559435;851.4720873058682;853.3045567862173;631.0282165465178;633.5121956093782;633.7655067625009;634.4733870887153;635.3805040085925;10956.945215273952;11042.558297668083;11055.613053543088;11178.04986576142;11257.831132533018;11135.888641113566;11185.552577896875;11207.271527350696;11252;11391.487383067783;9084.727458176265;9243.168114869693;9270.397424167408;9345.626174952993;9412.529373531295;3122.750179985596;3218.3241519280978;3251.398491279121;3258.2017405735746;3274.787138835968;33015.339693206;33393.16517087068;36897.63102368969;37351.252974940624;42495.787521062506;8933.19601235892;9078;9372.250219982385;9557;9614.663486777928;17186.828131718772;17203.741943870853;17230.569235768955;17249.91375043117;17268.827311726724;6187.731515039406;6199.039148931923;6240.157578726814;6265.467435267962;6326.873462530723;3255.3814775192636;3331.8833840815455;3332.9333413331597;3337.4826901830256;3415.55597772293;2594.169865642976;2610.6606141201523;2638.8416694998364;2642.828216165943;2654.9601755973677;466.6896513818341;470.02938931107155;476.8045101508365;477.87575230440336;480.3491269330077;477.4144343579865;536.5171345788822;562.4094700564391;605.0893405424896;613.1814028272306;7263.636818159071;7486.663100160506;7507.5870827103945;7631.7328893489575;7635.389168866588;588.0444278048171;596.4095545410013;601.173386593434;604.9909251361233;605.2283338743138;3549.0832772344042;3612.7471077024356;3622;3686.870959516404;3718.4236443351324;45733;46484.76757616258;53543;53854.46145538573;54185.45814541883;38373.424398634044;38389;38430.231395371935;39642;39805.402918956235;34468.65531344654;38980.6101938977;40047.39928901069;42197.78901105536;42330.15339693189;7285.890711639436;7637.923620763943;7990.240927111915;8031.277185053374;8037;31590;32070;32739.508907366886;32747.34505309928;32752;38585.614143859326;41118.58881411267;41245.58754412417;41373.79313103415;41531.1693766129;10179.338343007681;10215.233857460571;10438.68683939483;10470.790584188426;10490.108340791117;11557.88442115568;11699.649010529698;11701.005414539859;11723.296602203895;11742.647720568397;10714.410707411167;10927.56289748433;10971.890281097407;11300.830487542858;11446;10352.482375881025;10625.203109766644;10683.25217234786;10764.784704306026;10928.562857485611;10869.67390978272;10905.890941090487;10907.345559266469;10959.12327013821;10989.670309890716;9289.442633442015;9298.209652179641;9509.857352139861;9710.6115755369;9784.070513301225;9076.591553379982;9463.337566370288;9491.430514169171;9519.904800951901;9608.75978100553 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,322 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: __startTimestamp1449491708464__endTimestamp 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,472 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4584.27 Median:4715.25 stddev:487.38 (10.3%) stddev-sans-first:462.86 04:35:08 INFO - 2015-12-07 04:35:08,473 DEBUG : BROWSER_OUTPUT: Values: 2581.6 2627.5 2659.2 2668.5 2684.7 4476.5 4547.1 4644.3 4648.2 4667.7 4535.5 4540.3 4594.2 4621.8 4732.6 4199.3 4275.8 4284.0 4310.7 4331.3 4377.3 4387.2 4405.8 4454.2 4480.1 4106.9 4191.5 4220.3 4294.3 4404.0 4307.5 4308.1 4309.3 4333.1 4353.1 4296.6 4304.7 4307.5 4310.7 4345.1 4426.9 4438.1 4541.2 4631.8 4671.7 5009.6 5063.3 5065.7 5071.5 5094.0 4732.2 5083.2 5094.8 5102.5 5146.8 4553.0 4613.5 4677.8 4682.9 4715.5 5090.1 5116.9 5120.1 5131.7 5167.4 4720.5 4841.0 4906.0 4913.8 4946.4 4927.7 4987.0 5007.4 5019.2 5056.0 4925.4 4933.9 4938.4 4943.3 4986.7 4736.1 4788.5 4867.0 4938.1 4963.8 4088.2 4095.2 4104.5 4107.5 4127.9 3602.6 3606.8 3617.5 3633.7 3640.4 4086.7 4183.6 4202.2 4303.1 4305.9 5013.4 5024.0 5025.0 5048.1 5054.0 4313.8 4332.6 4333.1 4341.5 4380.8 4197.0 4260.7 4298.7 4317.2 4350.4 4719.1 4762.8 4803.8 4817.3 4836.2 4822.2 5078.1 5096.8 5102.5 5133.6 4670.4 4719.4 4719.5 4728.8 4833.3 4902.6 4907.8 4915.8 4924.1 4946.3 4969.0 4986.3 4988.7 5008.3 5049.9 4542.4 4634.0 4635.8 4646.4 4697.9 4740.2 4800.9 4808.0 4810.4 4852.5 4681.4 4709.1 4726.8 4729.4 4776.5 4643.8 4721.0 4749.4 4860.9 4884.8 4715.2 4750.5 4772.6 4773.2 4785.8 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39122.66 Median:16855.87 stddev:58792.08 (348.8%) stddev-sans-first:58885.61 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: Values: 534.9 567.9 574.3 593.9 601.7 37952.2 38401.1 38544.0 38591.0 38783.6 40361.0 40998.4 41049.2 41162.6 41439.8 7894.6 8073.8 8087.7 8095.3 8115.9 7891.9 7936.9 7946.8 8043.4 8051.2 7937.9 7961.2 7986.9 7996.1 8021.7 7938.2 7997.0 8014.7 8019.0 8041.2 7815.8 7974.4 7994.2 8001.2 8013.3 37413.8 37600.2 37789.0 37850.4 37976.8 2427.8 2492.7 2493.5 2493.5 2589.8 27244.5 27266.9 27292.7 27555.2 28055.4 3214.5 3220.9 3283.0 3292.6 3296.6 215078.0 218636.0 218814.0 218826.9 219413.0 47855.8 48591.5 54127.5 54588.2 54646.5 64300.4 65633.0 66265.0 66368.0 66444.3 14412.5 14724.8 14755.0 14778.2 14797.0 11226.0 11281.7 11354.6 11376.0 11464.0 18464.6 18526.5 18683.7 18748.3 18956.9 7567.8 7944.9 8019.8 8066.9 8071.5 903.6 932.4 941.9 1022.4 1071.1 26417.3 26540.5 26738.2 26754.3 26824.5 963.9 1019.4 1037.4 1045.5 1046.7 14114.0 14144.7 14161.4 14210.1 14225.0 204699.0 208264.0 208464.0 208728.0 209021.0 46038.0 46570.8 46976.3 47277.8 47286.5 1196.9 1226.5 1234.3 1261.9 1262.4 27173.0 27205.5 27440.0 27510.4 27922.4 40892.0 41100.8 41101.6 41115.2 41143.4 247383.0 250306.0 250670.0 250676.0 251489.0 28667.3 29359.9 29875.4 29964.3 29985.6 35083.0 35670.8 35683.0 35751.8 35801.6 29875.0 30029.8 30065.4 30297.8 30497.2 29481.3 29727.4 29817.4 30075.0 30406.8 32457.2 32646.5 33220.7 33388.3 33808.5 29243.0 29675.7 29963.9 30058.8 30119.7 23194.4 23197.0 23399.4 23439.9 23736.3 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24251.94 Median:335.36 stddev:63444.22 (18918.3%) stddev-sans-first:63596.78 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: Values: 334.8 335.2 335.5 336.2 336.3 10059.8 10136.5 10490.5 14822.0 15355.8 15688.5 15917.8 16111.1 16113.1 16348.3 5171.1 5253.0 5486.9 5487.5 5508.9 5450.3 5478.5 5486.2 5490.2 5493.4 3892.5 4017.6 5527.0 5530.7 6351.6 6520.2 6524.7 6528.3 6555.5 6566.1 5992.8 6063.1 6099.1 6102.7 6104.6 19936.6 20699.4 20787.8 22010.0 22266.4 1705.1 1711.8 1772.6 1868.9 1994.8 12217.4 12893.8 12899.5 13210.5 13299.8 1716.7 1727.6 1736.7 1742.6 1747.3 59186.7 61693.7 62579.0 63837.7 64196.4 15621.8 15666.8 15688.9 15697.2 15745.6 23160.5 23171.3 23219.0 23419.2 23491.2 8555.5 8889.6 8908.5 8945.1 9002.4 7470.7 7472.3 7545.7 7583.6 7607.5 7402.6 7534.8 7579.8 7668.6 7732.2 2944.4 2985.6 3074.7 3109.4 3174.1 761.4 767.8 959.2 962.5 994.8 15106.5 15646.5 15652.8 16719.9 17258.7 804.3 818.2 840.7 883.7 937.3 8695.5 9041.5 9074.5 9149.8 9468.0 310948.0 316954.0 317075.0 472252.0 475509.0 62134.0 70714.6 75477.2 75882.6 77179.6 997.8 1020.9 1032.9 1037.2 1038.8 14483.9 14673.8 14812.6 14813.7 15015.6 32246.5 32642.2 32733.7 33015.0 34022.8 43882.3 44572.3 44607.8 45868.3 45948.3 8694.0 8762.3 8809.5 8898.3 8919.7 10108.5 10122.6 10284.7 11410.8 16503.3 10350.0 10510.6 12642.7 12888.0 13166.6 11908.6 12215.2 12237.5 12713.7 12773.6 13453.5 13471.5 13664.6 13832.5 13873.1 8749.3 8758.8 8818.9 8839.2 8866.9 9256.4 9289.5 12413.5 13031.2 13062.6 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4980.67 Median:6181.11 stddev:2617.29 (42.3%) stddev-sans-first:2611.61 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: Values: 1506.9 1646.4 1699.3 1710.5 1728.4 5871.6 6260.3 6812.8 7105.3 7131.3 7036.8 7267.5 7326.6 7328.2 7334.3 2033.6 2077.9 2078.1 2105.4 2114.5 2050.9 2083.6 2090.4 2102.1 2120.4 2025.5 2052.7 2073.1 2080.4 2081.9 2079.9 2080.0 2095.1 2099.1 2113.2 2007.0 2020.6 2060.0 2062.5 2082.8 7267.6 7270.5 7274.7 7364.6 7371.2 4198.3 4267.4 4268.4 4272.3 4280.7 2624.3 2658.1 2690.0 2692.7 2710.2 760.4 763.5 768.5 806.0 836.1 9652.2 9686.7 9745.5 9756.0 9940.0 3883.7 3931.0 3950.4 3992.2 4001.6 8564.2 8584.3 8612.0 8619.5 8661.9 4349.8 4357.4 4358.5 4369.3 4419.9 3246.1 3379.7 3800.9 3955.3 3966.9 3443.9 3477.5 3505.0 3537.0 3546.5 1104.1 1114.9 1118.2 1120.6 1126.3 920.5 941.9 960.4 969.7 970.7 6936.3 6951.8 6973.8 6993.4 6995.6 416.2 419.2 429.0 435.0 440.0 5385.1 5465.1 5465.8 5472.4 5479.4 8055.3 8082.8 8111.1 8147.9 8236.6 8104.6 8136.0 8165.3 8183.6 8196.5 6271.3 6389.6 6426.2 6483.5 6489.6 6841.9 6984.5 6991.2 7005.0 7011.5 7829.3 7843.8 7909.1 8012.2 8035.6 8014.6 8089.5 8129.3 8160.8 8213.9 5176.2 5566.6 6064.6 6076.1 6176.9 6910.5 7006.2 7020.6 7050.0 7058.2 6339.3 6555.5 6623.6 6625.9 6676.3 6298.0 6404.9 6427.6 6588.9 6593.7 6185.4 6218.4 6235.1 6235.1 6252.9 5744.7 5869.9 5871.9 5881.0 5882.4 5889.2 5902.1 5937.3 5961.5 5979.6 04:35:08 INFO - 2015-12-07 04:35:08,474 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,475 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4672.52 Median:5403.30 stddev:1416.09 (26.2%) stddev-sans-first:1381.16 04:35:08 INFO - 2015-12-07 04:35:08,475 DEBUG : BROWSER_OUTPUT: Values: 280.8 284.6 290.1 290.2 292.4 5139.6 5428.3 5477.5 5523.9 5549.5 5335.3 5394.3 5401.9 5402.7 5403.9 4073.4 4077.3 4078.6 4089.4 4129.9 4078.6 4080.8 4083.4 4090.4 4131.5 3967.6 4027.8 4079.4 4097.3 4103.0 4031.3 4032.3 4037.3 4055.1 4082.1 3492.9 3495.1 3498.5 3506.1 3507.6 5112.1 5257.3 5261.8 5263.6 5283.2 4666.7 4680.6 4688.1 4689.8 4702.8 5696.9 5707.2 5711.5 5718.4 5719.6 3817.4 3821.3 3824.5 3829.8 3834.8 5862.3 5894.3 5912.2 5941.6 6001.9 3864.8 3901.9 3902.5 3911.6 3935.8 3989.5 3996.2 4007.4 4007.5 4010.8 4576.3 4582.0 4654.3 4665.2 4665.7 5389.2 5551.5 5551.7 5648.4 5663.0 1381.1 1402.1 1403.1 1403.9 1407.2 905.8 918.2 925.4 927.4 929.2 4836.5 4872.4 4937.5 4942.3 4947.8 5794.2 5799.3 5799.5 5800.2 5801.3 4866.1 4919.1 4927.1 4927.5 4940.6 3091.2 3106.5 3148.6 3179.6 3188.1 5535.6 5603.9 5608.0 5617.3 5623.7 6118.9 6118.9 6123.8 6130.0 6133.4 5583.0 5603.0 5608.4 5610.1 5613.1 5761.9 5965.5 5969.3 5971.9 5983.0 5797.8 5838.9 5848.0 5851.6 5852.1 5617.1 5619.5 5631.5 5636.8 5636.9 3832.3 3882.3 3910.6 3930.9 3935.4 5750.2 5861.6 5938.3 5940.3 5959.1 5568.6 5635.6 5645.5 5687.9 5710.9 5633.0 5641.2 5699.6 5709.4 5720.2 5454.1 5590.9 5591.4 5595.9 5596.2 5720.8 5757.4 5769.8 5777.2 5778.9 5584.2 5594.3 5600.5 5602.1 5609.3 04:35:08 INFO - 2015-12-07 04:35:08,476 DEBUG : BROWSER_OUTPUT: 04:35:08 INFO - 2015-12-07 04:35:08,476 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12059.24 Median:41452.48 stddev:13441.54 (32.4%) stddev-sans-first:13452.49 04:35:08 INFO - 2015-12-07 04:35:08,476 DEBUG : BROWSER_OUTPUT: Values: 766.3 770.4 779.6 791.3 793.6 11092.6 11365.5 11398.3 11406.7 11420.8 10648.3 11096.8 11279.7 11367.5 11401.8 802.1 821.8 821.9 822.5 822.9 811.3 814.3 819.2 819.5 820.2 848.9 852.0 856.3 856.5 861.8 841.6 845.3 850.8 851.5 853.3 631.0 633.5 633.8 634.5 635.4 10956.9 11042.6 11055.6 11178.0 11257.8 11135.9 11185.6 11207.3 11252.0 11391.5 9084.7 9243.2 9270.4 9345.6 9412.5 3122.8 3218.3 3251.4 3258.2 3274.8 33015.3 33393.2 36897.6 37351.3 42495.8 8933.2 9078.0 9372.3 9557.0 9614.7 17186.8 17203.7 17230.6 17249.9 17268.8 6187.7 6199.0 6240.2 6265.5 6326.9 3255.4 3331.9 3332.9 3337.5 3415.6 2594.2 2610.7 2638.8 2642.8 2655.0 466.7 470.0 476.8 477.9 480.3 477.4 536.5 562.4 605.1 613.2 7263.6 7486.7 7507.6 7631.7 7635.4 588.0 596.4 601.2 605.0 605.2 3549.1 3612.7 3622.0 3686.9 3718.4 45733.0 46484.8 53543.0 53854.5 54185.5 38373.4 38389.0 38430.2 39642.0 39805.4 34468.7 38980.6 40047.4 42197.8 42330.2 7285.9 7637.9 7990.2 8031.3 8037.0 31590.0 32070.0 32739.5 32747.3 32752.0 38585.6 41118.6 41245.6 41373.8 41531.2 10179.3 10215.2 10438.7 10470.8 10490.1 11557.9 11699.6 11701.0 11723.3 11742.6 10714.4 10927.6 10971.9 11300.8 11446.0 10352.5 10625.2 10683.3 10764.8 10928.6 10869.7 10905.9 10907.3 10959.1 10989.7 9289.4 9298.2 9509.9 9710.6 9784.1 9076.6 9463.3 9491.4 9519.9 9608.8 04:35:08 INFO - 2015-12-07 04:35:08,476 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:35:08 INFO - 2015-12-07 04:35:08,476 DEBUG : BROWSER_OUTPUT: 04:35:09 INFO - 2015-12-07 04:35:09,203 INFO : Browser exited with error code: 0 04:35:09 INFO - 2015-12-07 04:35:09,219 INFO : Completed test dromaeo_css (00:18:36) 04:35:09 INFO - 2015-12-07 04:35:09,219 INFO : Starting test kraken 04:35:09 INFO - 2015-12-07 04:35:09,219 DEBUG : operating with platform_type : linux_ 04:35:09 INFO - 2015-12-07 04:35:09,219 INFO : Initialising browser for kraken test... 04:35:09 INFO - 2015-12-07 04:35:09,225 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT51UF/profile http://localhost:50864/getInfo.html 04:35:14 INFO - 2015-12-07 04:35:14,107 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:35:14 INFO - 2015-12-07 04:35:14,108 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:35:14 INFO - 2015-12-07 04:35:14,108 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:35:14 INFO - 2015-12-07 04:35:14,108 DEBUG : BROWSER_OUTPUT: __metrics 04:35:14 INFO - 2015-12-07 04:35:14,233 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:35:15 INFO - 2015-12-07 04:35:15,179 INFO : Browser initialized. 04:35:15 INFO - 2015-12-07 04:35:15,179 INFO : Running cycle 1/1 for kraken test... 04:35:15 INFO - 2015-12-07 04:35:15,179 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKT51UF/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:35:27 INFO - 2015-12-07 04:35:27,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 142716928 04:35:27 INFO - 2015-12-07 04:35:27,194 DEBUG : BROWSER_OUTPUT: 04:35:29 INFO - 2015-12-07 04:35:29,790 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-beat-detection) 04:35:30 INFO - 2015-12-07 04:35:30,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 143507456 04:35:30 INFO - 2015-12-07 04:35:30,404 DEBUG : BROWSER_OUTPUT: 04:35:33 INFO - 2015-12-07 04:35:33,207 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-dft) 04:35:33 INFO - 2015-12-07 04:35:33,813 DEBUG : BROWSER_OUTPUT: RSS: Main: 144502784 04:35:33 INFO - 2015-12-07 04:35:33,813 DEBUG : BROWSER_OUTPUT: 04:35:36 INFO - 2015-12-07 04:35:36,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-fft) 04:35:37 INFO - 2015-12-07 04:35:37,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 138792960 04:35:37 INFO - 2015-12-07 04:35:37,309 DEBUG : BROWSER_OUTPUT: 04:35:39 INFO - 2015-12-07 04:35:39,421 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50864/tests/kraken/driver.html?testName=audio-oscillator) 04:35:40 INFO - 2015-12-07 04:35:40,002 DEBUG : BROWSER_OUTPUT: RSS: Main: 138772480 04:35:40 INFO - 2015-12-07 04:35:40,002 DEBUG : BROWSER_OUTPUT: 04:35:42 INFO - 2015-12-07 04:35:42,256 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:35:42 INFO - 2015-12-07 04:35:42,845 DEBUG : BROWSER_OUTPUT: RSS: Main: 140967936 04:35:42 INFO - 2015-12-07 04:35:42,846 DEBUG : BROWSER_OUTPUT: 04:35:45 INFO - 2015-12-07 04:35:45,889 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-darkroom) 04:35:46 INFO - 2015-12-07 04:35:46,491 DEBUG : BROWSER_OUTPUT: RSS: Main: 140476416 04:35:46 INFO - 2015-12-07 04:35:46,491 DEBUG : BROWSER_OUTPUT: 04:35:50 INFO - 2015-12-07 04:35:50,004 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50864/tests/kraken/driver.html?testName=imaging-desaturate) 04:35:50 INFO - 2015-12-07 04:35:50,605 DEBUG : BROWSER_OUTPUT: RSS: Main: 138760192 04:35:50 INFO - 2015-12-07 04:35:50,606 DEBUG : BROWSER_OUTPUT: 04:35:53 INFO - 2015-12-07 04:35:53,531 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50864/tests/kraken/driver.html?testName=json-parse-financial) 04:35:54 INFO - 2015-12-07 04:35:54,132 DEBUG : BROWSER_OUTPUT: RSS: Main: 139554816 04:35:54 INFO - 2015-12-07 04:35:54,132 DEBUG : BROWSER_OUTPUT: 04:35:55 INFO - 2015-12-07 04:35:55,901 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50864/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:35:56 INFO - 2015-12-07 04:35:56,483 DEBUG : BROWSER_OUTPUT: RSS: Main: 141037568 04:35:56 INFO - 2015-12-07 04:35:56,483 DEBUG : BROWSER_OUTPUT: 04:35:58 INFO - 2015-12-07 04:35:58,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:35:58 INFO - 2015-12-07 04:35:58,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 141520896 04:35:58 INFO - 2015-12-07 04:35:58,972 DEBUG : BROWSER_OUTPUT: 04:36:01 INFO - 2015-12-07 04:36:01,135 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:36:01 INFO - 2015-12-07 04:36:01,737 DEBUG : BROWSER_OUTPUT: RSS: Main: 141746176 04:36:01 INFO - 2015-12-07 04:36:01,737 DEBUG : BROWSER_OUTPUT: 04:36:04 INFO - 2015-12-07 04:36:04,292 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:36:04 INFO - 2015-12-07 04:36:04,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 139776000 04:36:04 INFO - 2015-12-07 04:36:04,906 DEBUG : BROWSER_OUTPUT: 04:36:07 INFO - 2015-12-07 04:36:07,441 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:36:08 INFO - 2015-12-07 04:36:08,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 140734464 04:36:08 INFO - 2015-12-07 04:36:08,035 DEBUG : BROWSER_OUTPUT: 04:36:09 INFO - 2015-12-07 04:36:09,792 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50864/tests/kraken/driver.html?testName=ai-astar) 04:36:10 INFO - 2015-12-07 04:36:10,042 DEBUG : BROWSER_OUTPUT: RSS: Main: 141008896 04:36:10 INFO - 2015-12-07 04:36:10,042 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;110;113;113;112;129;113;113;112;112 04:36:10 INFO - 2015-12-07 04:36:10,046 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;131;161;164;133;159;161;146;171;133 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;164;164;164;161;168;168;164;163;164 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |3;audio-fft;77;73;72;75;151;75;74;73;72;157 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;145;95;95;95;136;95;97;131 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;112;110;111;110;110;110;112;111 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;150;150;165;151;150;148;149;149;148 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;97;98;96;96;96;97;98;96;102;96 04:36:10 INFO - 2015-12-07 04:36:10,047 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;72;72;78;73;75;85;73;72 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;71;69;68;69;67;69;67;69;68 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;85;82;84;86;87;84;86;85;96;86 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;124;133;136;129;124;123;127;126;127 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;134;146;135;149;147;134;145;137;137;137 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;68;71;72;70;68;70;69;71 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:36:10 INFO - 2015-12-07 04:36:10,048 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,791 04:36:10 INFO - 2015-12-07 04:36:10,049 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:36:10 INFO - 2015-12-07 04:36:10,049 DEBUG : BROWSER_OUTPUT: __startTimestamp1449491770044__endTimestamp 04:36:10 INFO - 2015-12-07 04:36:10,049 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,052 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:36:10 INFO - 2015-12-07 04:36:10,052 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:36:10 INFO - 2015-12-07 04:36:10,052 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,052 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.10 Median:113.00 stddev:5.34 (4.7%) stddev-sans-first:5.67 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 114.0 110.0 113.0 113.0 112.0 129.0 113.0 113.0 112.0 112.0 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.60 Median:160.00 stddev:14.68 (9.2%) stddev-sans-first:15.44 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 157.0 131.0 161.0 164.0 133.0 159.0 161.0 146.0 171.0 133.0 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.40 Median:164.00 stddev:2.12 (1.3%) stddev-sans-first:2.24 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 164.0 164.0 161.0 168.0 168.0 164.0 163.0 164.0 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:89.90 Median:73.50 stddev:33.85 (46.1%) stddev-sans-first:35.58 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 77.0 73.0 72.0 75.0 151.0 75.0 74.0 73.0 72.0 157.0 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:108.00 Median:95.00 stddev:20.53 (21.6%) stddev-sans-first:21.23 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 145.0 95.0 95.0 95.0 136.0 95.0 97.0 131.0 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.60 Median:110.50 stddev:0.84 (0.8%) stddev-sans-first:0.87 04:36:10 INFO - 2015-12-07 04:36:10,053 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 112.0 110.0 111.0 110.0 110.0 110.0 112.0 111.0 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:150.80 Median:150.00 stddev:5.09 (3.4%) stddev-sans-first:5.30 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: Values: 148.0 150.0 150.0 165.0 151.0 150.0 148.0 149.0 149.0 148.0 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:97.20 Median:96.50 stddev:1.87 (1.9%) stddev-sans-first:1.99 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: Values: 97.0 98.0 96.0 96.0 96.0 97.0 98.0 96.0 102.0 96.0 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.70 Median:73.50 stddev:4.06 (5.5%) stddev-sans-first:4.29 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 72.0 72.0 78.0 73.0 75.0 85.0 73.0 72.0 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 69.0 68.0 69.0 67.0 69.0 67.0 69.0 68.0 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.10 Median:86.00 stddev:3.75 (4.4%) stddev-sans-first:3.96 04:36:10 INFO - 2015-12-07 04:36:10,054 DEBUG : BROWSER_OUTPUT: Values: 85.0 82.0 84.0 86.0 87.0 84.0 86.0 85.0 96.0 86.0 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:127.10 Median:127.00 stddev:4.48 (3.5%) stddev-sans-first:4.36 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: Values: 122.0 124.0 133.0 136.0 129.0 124.0 123.0 127.0 126.0 127.0 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:140.10 Median:141.00 stddev:5.92 (4.2%) stddev-sans-first:5.85 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: Values: 134.0 146.0 135.0 149.0 147.0 134.0 145.0 137.0 137.0 137.0 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.90 Median:70.50 stddev:1.37 (1.9%) stddev-sans-first:1.39 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 68.0 71.0 72.0 70.0 68.0 70.0 69.0 71.0 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:36:10 INFO - 2015-12-07 04:36:10,055 DEBUG : BROWSER_OUTPUT: 04:36:11 INFO - 2015-12-07 04:36:11,019 INFO : Browser exited with error code: 0 04:36:11 INFO - 2015-12-07 04:36:11,069 INFO : Completed test kraken (00:01:01) 04:36:11 INFO - 2015-12-07 04:36:11,070 INFO : Starting test v8_7 04:36:11 INFO - 2015-12-07 04:36:11,070 DEBUG : operating with platform_type : linux_ 04:36:11 INFO - 2015-12-07 04:36:11,070 INFO : Initialising browser for v8_7 test... 04:36:11 INFO - 2015-12-07 04:36:11,076 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3GrOV3/profile http://localhost:50864/getInfo.html 04:36:15 INFO - 2015-12-07 04:36:15,832 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:36:15 INFO - 2015-12-07 04:36:15,832 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:36:15 INFO - 2015-12-07 04:36:15,832 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:36:15 INFO - 2015-12-07 04:36:15,832 DEBUG : BROWSER_OUTPUT: __metrics 04:36:15 INFO - 2015-12-07 04:36:15,961 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/PerformanceStats.jsm, line 211: NS_ERROR_NOT_AVAILABLE: Component returned failure code: 0x80040111 (NS_ERROR_NOT_AVAILABLE) [nsIPerformanceStatsService.isMonitoringJank] 04:36:16 INFO - 2015-12-07 04:36:16,915 INFO : Browser initialized. 04:36:16 INFO - 2015-12-07 04:36:16,915 INFO : Running cycle 1/1 for v8_7 test... 04:36:16 INFO - 2015-12-07 04:36:16,915 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3GrOV3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:36:28 INFO - 2015-12-07 04:36:28,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 142598144 04:36:28 INFO - 2015-12-07 04:36:28,864 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,377 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50864/tests/v8_7/run.html (next: http://localhost:50864/tests/v8_7/run.html) 04:36:50 INFO - 2015-12-07 04:36:50,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 137564160 04:36:50 INFO - 2015-12-07 04:36:50,623 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: |0;Richards;167.2800267648043 04:36:50 INFO - 2015-12-07 04:36:50,625 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;183.3180568285976 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.9321845469705 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5256.544502617801 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1085.6832971800434 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |5;Earley;713.7758743754462 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |6;Boyer;12108.43373493976 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |7;RegExp;25550 04:36:50 INFO - 2015-12-07 04:36:50,626 DEBUG : BROWSER_OUTPUT: |8;Splay;602.4096385542168 04:36:50 INFO - 2015-12-07 04:36:50,627 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:36:50 INFO - 2015-12-07 04:36:50,627 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:36:50 INFO - 2015-12-07 04:36:50,627 DEBUG : BROWSER_OUTPUT: __startTimestamp1449491810624__endTimestamp 04:36:50 INFO - 2015-12-07 04:36:50,627 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,627 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:36:50 INFO - 2015-12-07 04:36:50,628 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:36:50 INFO - 2015-12-07 04:36:50,628 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,628 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.28 Median:167.28 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,628 DEBUG : BROWSER_OUTPUT: Values: 167.3 04:36:50 INFO - 2015-12-07 04:36:50,628 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,629 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:183.32 Median:183.32 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,629 DEBUG : BROWSER_OUTPUT: Values: 183.3 04:36:50 INFO - 2015-12-07 04:36:50,629 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,629 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.93 Median:277.93 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,629 DEBUG : BROWSER_OUTPUT: Values: 277.9 04:36:50 INFO - 2015-12-07 04:36:50,630 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,630 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5256.54 Median:5256.54 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,630 DEBUG : BROWSER_OUTPUT: Values: 5256.5 04:36:50 INFO - 2015-12-07 04:36:50,630 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,630 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1085.68 Median:1085.68 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: Values: 1085.7 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:713.78 Median:713.78 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: Values: 713.8 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,631 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12108.43 Median:12108.43 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,632 DEBUG : BROWSER_OUTPUT: Values: 12108.4 04:36:50 INFO - 2015-12-07 04:36:50,632 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,632 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:25550.00 Median:25550.00 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,632 DEBUG : BROWSER_OUTPUT: Values: 25550.0 04:36:50 INFO - 2015-12-07 04:36:50,632 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:602.41 Median:602.41 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: Values: 602.4 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:36:50 INFO - 2015-12-07 04:36:50,633 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:36:50 INFO - 2015-12-07 04:36:50,634 DEBUG : BROWSER_OUTPUT: 04:36:51 INFO - 2015-12-07 04:36:51,599 INFO : Browser exited with error code: 0 04:36:51 INFO - 2015-12-07 04:36:51,613 INFO : Completed test v8_7 (00:00:40) 04:36:51 INFO - 2015-12-07 04:36:51,622 INFO : Completed test suite (00:20:18) 04:36:51 INFO - 2015-12-07 04:36:51,622 DEBUG : Working with test: dromaeo_css 04:36:51 INFO - 2015-12-07 04:36:51,622 DEBUG : Generating results file: dromaeo_css 04:36:51 INFO - 2015-12-07 04:36:51,623 DEBUG : Working with test: kraken 04:36:51 INFO - 2015-12-07 04:36:51,623 DEBUG : Generating results file: kraken 04:36:51 INFO - 2015-12-07 04:36:51,624 INFO : javascript benchmark 04:36:51 INFO - 2015-12-07 04:36:51,624 DEBUG : Working with test: v8_7 04:36:51 INFO - 2015-12-07 04:36:51,624 DEBUG : Generating results file: v8_7 04:36:51 INFO - 2015-12-07 04:36:51,624 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:51 INFO - 2015-12-07 04:36:51,678 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 04:36:51 INFO - 2015-12-07 04:36:51,678 DEBUG : process_Request line: dromaeo_css 6351.67 graph.html#tests=[[72,94,43]] 04:36:51 INFO - 2015-12-07 04:36:51,678 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:51 INFO - 2015-12-07 04:36:51,707 DEBUG : process_Request line: kraken 1553.00 graph.html#tests=[[232,94,43]] 04:36:51 INFO - 2015-12-07 04:36:51,708 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:36:51 INFO - 2015-12-07 04:36:51,750 DEBUG : process_Request line: v8_7 21378.78 graph.html#tests=[[230,94,43]] 04:36:51 INFO - 2015-12-07 04:36:51,752 INFO : javascript benchmark 04:36:51 INFO - 2015-12-07 04:36:51,755 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2581.5998520229364, 2627.5401804684197, 2659.202239328201, 2668.5063263296292, 2684.6644169478814, 4476.529964353745, 4547.113312903985, 4644.34979102925, 4648.209804333263, 4667.69659972102, 4535.546445355463, 4540.341650460689, 4594.218982772928, 4621.792019359128, 4732.574068333849, 4199.2651286024975, 4275.786210689469, 4283.957160428403, 4310.741355518679, 4331.263685173512, 4377.277749171383, 4387.23223435899, 4405.8237670493145, 4454.175977444167, 4480.126375356806, 4106.938395924063, 4191.476065491814, 4220.261454245526, 4294.291441912081, 4403.977980110111, 4307.547707490699, 4308.138372325548, 4309.288967320388, 4333.090051089275, 4353.10761293934, 4296.591823776736, 4304.655627549789, 4307.5261721210645, 4310.698251122422, 4345.06581085065, 4426.889327766799, 4438.134563760068, 4541.227991241464, 4631.768411579407, 4671.672982891199, 5009.624278179152, 5063.291139240509, 5065.746712664352, 5071.518205770446, 5093.974530127362, 4732.1718699227495, 5083.186690129562, 5094.821681241176, 5102.515261050195, 5146.794128234867, 4552.954470455253, 4613.469451013109, 4677.766111694402, 4682.859514214579, 4715.457722361973, 5090.134677104901, 5116.948830511647, 5120.103981803244, 5131.7177555234075, 5167.405748338989, 4720.504347043511, 4841.031793641286, 4906.0, 4913.828016019422, 4946.431160416598, 4927.704337739747, 4986.950130498649, 5007.4491805901325, 5019.247112933089, 5055.974720126376, 4925.38432695913, 4933.925991110136, 4938.358013458299, 4943.332650092263, 4986.675866068694, 4736.100140973204, 4788.521147885183, 4866.975665121652, 4938.111139994764, 4963.8262660806695, 4088.223237584909, 4095.1809638072505, 4104.52797928242, 4107.54816970133, 4127.938080928789, 3602.6397360264286, 3606.783592984429, 3617.5478065241846, 3633.691136253448, 3640.4175331946763, 4086.6526345260986, 4183.644390226804, 4202.201581699467, 4303.1393721255245, 4305.870823875289, 5013.423456302499, 5023.974880125576, 5025.045241404122, 5048.0913435581215, 5054.0, 4313.827446902152, 4332.610065094093, 4333.090051089306, 4341.5007274163245, 4380.78096095194, 4196.958030419718, 4260.723053001545, 4298.699091063596, 4317.201317756162, 4350.390945267665, 4719.126961512131, 4762.833300834454, 4803.807847686054, 4817.301491283814, 4836.153673107192, 4822.228443449031, 5078.08594453002, 5096.847094587169, 5102.515261050195, 5133.56364708989, 4670.4395472542155, 4719.433667959729, 4719.528047195253, 4728.787204575871, 4833.250846118857, 4902.60779137661, 4907.803687852446, 4915.7542122893, 4924.089043526959, 4946.258061290835, 4969.0, 4986.276989836526, 4988.72562009093, 5008.273800299009, 5049.924251136309, 4542.364069030405, 4633.953660463352, 4635.768211589474, 4646.3727396801, 4697.906041879211, 4740.194166991689, 4800.855974320776, 4808.014357056865, 4810.350602668595, 4852.514748525119, 4681.368015317888, 4709.081729062937, 4726.7636618169645, 4729.43246810385, 4776.522347765195, 4643.767811609338, 4721.0, 4749.35883655702, 4860.902781944412, 4884.780184891617, 4715.24556071027, 4750.52494750536, 4772.570468657837, 4773.188557945227, 4785.808567657255], "unit": "ms", "name": "dojo.html", "value": 4553.534735824152}, {"lowerIsBetter": false, "replicates": [534.8685682054673, 567.9204911312416, 574.3395095640016, 593.8990371636821, 601.7292218501674, 37952.24095518088, 38401.119916006304, 38544.0, 38590.99999999996, 38783.61216387835, 40361.0, 40998.38502422466, 41049.17901641973, 41162.58837411625, 41439.792801035954, 7894.6052697365185, 8073.798155046112, 8087.716929907425, 8095.271425571697, 8115.918840811605, 7891.921080789205, 7936.880946785803, 7946.801329966739, 8043.396745244101, 8051.2351326623875, 7937.880931785999, 7961.203879612021, 7986.920130798676, 7996.120426753053, 8021.67913283468, 7938.206179382045, 7996.960015199916, 8014.679412823451, 8019.0, 8041.236082572204, 7815.8436831263625, 7974.401919856034, 7994.160613135653, 8001.239882211239, 8013.278804907528, 37413.81293093544, 37600.24799503994, 37789.0, 37850.432243516094, 37976.81011594952, 2427.757224277576, 2492.700875894886, 2493.4514406830467, 2493.501299740059, 2589.8057645676463, 27244.45511089767, 27266.863665681543, 27292.727072729216, 27555.17334479949, 28055.43889122206, 3214.5017522284083, 3220.935581288361, 3282.9822754945803, 3292.5719656444508, 3296.5549650797075, 215078.0, 218636.0, 218814.0, 218826.90586547126, 219413.0, 47855.76072119617, 48591.51408485941, 54127.45872541303, 54588.18117728158, 54646.453535464934, 64300.356996430375, 65633.0, 66265.0, 66368.0, 66444.33555664479, 14412.495562655256, 14724.779128313085, 14755.0, 14778.187199703905, 14797.0, 11226.0, 11281.661550153509, 11354.602588909349, 11376.033037191932, 11464.0, 18464.63070738578, 18526.536836579195, 18683.719744203576, 18748.343807966656, 18956.905215473835, 7567.810804729926, 7944.920550794418, 8019.759407217793, 8066.878996815052, 8071.515709057476, 903.5708038681573, 932.3659911260272, 941.8587211918131, 1022.3712416863575, 1071.1430855315716, 26417.33956651099, 26540.46919061608, 26738.19785406441, 26754.331141721614, 26824.463510729674, 963.8554216867386, 1019.3730855523947, 1037.444966942682, 1045.5086109528509, 1046.6598355534481, 14114.0, 14144.71710565783, 14161.362738676784, 14210.147391156564, 14225.0, 204699.0, 208264.0, 208464.0, 208728.0, 209021.0, 46038.0, 46570.76714616405, 46976.295355569695, 47277.76361118173, 47286.52713472821, 1196.9281843089443, 1226.47874653272, 1234.2779474007627, 1261.8801213884667, 1262.3940508555945, 27173.0, 27205.455890882466, 27440.0, 27510.449791003666, 27922.441551168456, 40892.0, 41100.79449602733, 41101.588984109774, 41115.1776964465, 41143.38284925669, 247383.0, 250306.0, 250670.0, 250676.0, 251489.0, 28667.28331791722, 29359.853200733858, 29875.402491950474, 29964.250893727833, 29985.550216747204, 35083.0, 35670.75152369655, 35683.0, 35751.82124089363, 35801.64198358087, 29875.0, 30029.84985075148, 30065.3986920256, 30297.848510757307, 30497.23756906095, 29481.262968425963, 29727.405451891274, 29817.403651926405, 30075.0, 30406.84796576003, 32457.188570285933, 32646.51030234596, 33220.66779332176, 33388.332233355686, 33808.49287260644, 29243.0, 29675.703242967294, 29963.850180748956, 30058.84970575133, 30119.698803011688, 23194.420139496648, 23197.0, 23399.41501462477, 23439.88280058589, 23736.287911362688], "unit": "ms", "name": "ext.html", "value": 16800.861556198746}, {"lowerIsBetter": false, "replicates": [334.76566403517546, 335.20221871944767, 335.51685572775204, 336.1797214795898, 336.34245050925443, 10059.849102263472, 10136.493175341231, 10490.527926243318, 14822.0, 15355.846441535596, 15688.529344119666, 15917.761233581477, 16111.113888736145, 16113.113778742165, 16348.264328105233, 5171.09505836479, 5253.0, 5486.890262194754, 5487.478689524489, 5508.898220355944, 5450.264214331054, 5478.534324582415, 5486.204500347447, 5490.231367608518, 5493.395726470085, 3892.4550562921213, 4017.6183262590007, 5527.0, 5530.695811730353, 6351.587146835464, 6520.18497687789, 6524.706388212542, 6528.281888992207, 6555.50833687473, 6566.080748695186, 5992.79025234119, 6063.060225665029, 6099.085137229406, 6102.72537735803, 6104.572679912408, 19936.601267974704, 20699.379018629465, 20787.792122078736, 22010.0, 22266.443338916495, 1705.0792572011098, 1711.7774689290436, 1772.6011647379237, 1868.870259958255, 1994.8204661580382, 12217.389130543526, 12893.806592901114, 12899.484020639164, 13210.471581136742, 13299.800502992462, 1716.6909956207878, 1727.6285598596237, 1736.7308067249596, 1742.6166243426426, 1747.2574155983657, 59186.70406647939, 61693.69153154251, 62579.0, 63837.68081159611, 64196.35803641951, 15621.843781562266, 15666.764998525032, 15688.921555392379, 15697.215139242991, 15745.606359840867, 23160.536789264457, 23171.3048608542, 23219.0, 23419.180328688755, 23491.17780877661, 8555.529445880537, 8889.64441422336, 8908.510031948304, 8945.06076861933, 9002.369834111549, 7470.663820128108, 7472.29013243741, 7545.698172073166, 7583.62081895903, 7607.543547387064, 7402.592857392788, 7534.773956781196, 7579.772606821693, 7668.622726954662, 7732.226777322336, 2944.4111177764103, 2985.5521671748975, 3074.6925307469523, 3109.3936682347176, 3174.1112488503254, 761.3756719489965, 767.8272388712495, 959.165525992391, 962.4946902876046, 994.8209322321907, 15106.54680359591, 15646.452374167076, 15652.843471565138, 16719.91640041792, 17258.654826903392, 804.3042768005633, 818.2104269380077, 840.6973489543759, 883.6730409748434, 937.3063932689761, 8695.478271303742, 9041.457512549268, 9074.546272686339, 9149.81700365989, 9467.952660236655, 310948.0, 316954.0, 317075.0, 472252.0, 475509.0, 62134.0, 70714.64642676753, 75477.24522754812, 75882.62058689671, 77179.61410192912, 997.7777222901888, 1020.8979102089731, 1032.9225308101923, 1037.1858091398217, 1038.7662775875367, 14483.855161448251, 14673.779893301395, 14812.555623331318, 14813.703725925636, 15015.624609384417, 32246.516302255954, 32642.183945400604, 32733.67266327306, 33015.0, 34022.82988585041, 43882.341764872916, 44572.331415029446, 44607.776961114985, 45868.31197531973, 45948.310775339065, 8694.0, 8762.29901607857, 8809.471431714117, 8898.288136948899, 8919.73240802777, 10108.494575271354, 10122.59509619607, 10284.691459255935, 11410.82883756761, 16503.33986640521, 10350.0, 10510.632127875488, 12642.747145056863, 12888.0, 13166.605001849959, 11908.583199587973, 12215.206011609216, 12237.510499580274, 12713.745725085631, 12773.552925647558, 13453.529126480918, 13471.461141554228, 13664.590062298146, 13832.515861945187, 13873.098248613807, 8749.256313213447, 8758.82482350362, 8818.867716984121, 8839.204471597586, 8866.911330886609, 9256.352055356061, 9289.535523223676, 12413.503459861504, 13031.218126912416, 13062.608121756362], "unit": "ms", "name": "jquery.html", "value": 8926.670331792886}, {"lowerIsBetter": false, "replicates": [1506.8794496440287, 1646.4319809665667, 1699.2608215426283, 1710.4783041172445, 1728.438257566291, 5871.647701137924, 6260.280067792205, 6812.761553345634, 7105.324994125563, 7131.322524360177, 7036.788896333118, 7267.527610705313, 7326.560406375608, 7328.230535793745, 7334.3032411920785, 2033.5932813437335, 2077.9168833246654, 2078.1375729072415, 2105.442057854662, 2114.4925217947734, 2050.9384718458396, 2083.6353638113346, 2090.4460318015663, 2102.0750869617395, 2120.3850883243917, 2025.5341271507489, 2052.692096185569, 2073.0982022820044, 2080.4174831047253, 2081.916723331065, 2079.906404211814, 2080.043180137131, 2095.078165607136, 2099.0973881231066, 2113.186423227053, 2007.046652839904, 2020.6463868822898, 2059.9588008239903, 2062.5256191076137, 2082.79172082792, 7267.636618169124, 7270.454715896276, 7274.672639731225, 7364.594947277951, 7371.189169191384, 4198.265303571863, 4267.381229721673, 4268.359746038088, 4272.316429371285, 4280.657547396201, 2624.317677403889, 2658.1095333063445, 2689.9596506052426, 2692.7172646872186, 2710.2004908551826, 760.3954855889581, 763.4617594595796, 768.5196752029981, 805.9556724380157, 836.0761358698672, 9652.22782177424, 9686.70939871805, 9745.512724363753, 9755.951220243924, 9940.0, 3883.6893048556612, 3930.9803450982563, 3950.4469374287623, 3992.2414741199077, 4001.579834117376, 8564.229219370287, 8584.270337021424, 8612.0, 8619.525926074, 8661.913380866237, 4349.782510874444, 4357.411749413788, 4358.5205627380965, 4369.344598310279, 4419.911601767946, 3246.1397729601676, 3379.746519011084, 3800.8859734208017, 3955.3275943089743, 3966.8809935701975, 3443.9311213776086, 3477.5305333779615, 3504.9649503505148, 3536.9823150884595, 3546.4503002034726, 1104.100158370925, 1114.9331040137617, 1118.189312748251, 1120.56298043763, 1126.2679258482053, 920.5167287174287, 941.8540126280437, 960.3901522533241, 969.6509256667593, 970.7039352997404, 6936.34104760047, 6951.7914462566205, 6973.79078627642, 6993.440524758007, 6995.580265184105, 416.2216654855379, 419.20351332468556, 428.98069586868667, 434.9956500435018, 440.0275391385011, 5385.111456609694, 5465.07093794048, 5465.754041068082, 5472.398036216013, 5479.397266300703, 8055.275025247639, 8082.838343233102, 8111.148329425443, 8147.918520814835, 8236.629351679188, 8104.635291411901, 8136.023677158661, 8165.346772258205, 8183.590820458953, 8196.508209507329, 6271.31015588294, 6389.648569328639, 6426.228852537725, 6483.546151769331, 6489.610623362613, 6841.93158068413, 6984.476164287597, 6991.161060672752, 7005.0, 7011.50919435655, 7829.3345065670055, 7843.764687059397, 7909.05091389037, 8012.238837310446, 8035.638396272065, 8014.559199244098, 8089.514629122272, 8129.309008734087, 8160.795980100545, 8213.876791848008, 5176.197689358156, 5566.610337276514, 6064.605800622945, 6076.058210977306, 6176.876462470816, 6910.481713871379, 7006.229314775473, 7020.613866237406, 7049.9647501762165, 7058.188308344606, 6339.270983836917, 6555.541112122106, 6623.602583844985, 6625.867482650224, 6676.298988606321, 6297.96851015742, 6404.935950640434, 6427.58220715652, 6588.901166482602, 6593.736250549924, 6185.350538193605, 6218.409251121137, 6235.064740288993, 6235.127082208403, 6252.906206406817, 5744.741486633028, 5869.911951320648, 5871.853203669943, 5880.970595146997, 5882.352941176553, 5889.234399528034, 5902.1146827976145, 5937.2578427696535, 5961.463468287875, 5979.551533635082], "unit": "ms", "name": "mootools.html", "value": 3998.030202622621}, {"lowerIsBetter": false, "replicates": [280.76976878959255, 284.63140233397746, 290.078999177611, 290.2004976290321, 292.3568150069847, 5139.614528910337, 5428.348598168225, 5477.4796394342575, 5523.861903452415, 5549.4728000839905, 5335.253064570963, 5394.271773310602, 5401.945980540193, 5402.6758394496255, 5403.918941215885, 4073.40935564343, 4077.2660921034203, 4078.5717499662555, 4089.386592011207, 4129.938050929223, 4078.6125318094882, 4080.8367665293354, 4083.4487344208596, 4090.386442033689, 4131.52487463941, 3967.642912137907, 4027.758334499925, 4079.3676980068135, 4097.323941549641, 4103.035786590149, 4031.3348297530874, 4032.3145065338963, 4037.3338399164104, 4055.1484188320487, 4082.0611259410207, 3492.8777492787885, 3495.0563347895927, 3498.492718555821, 3506.053365591276, 3507.631698671654, 5112.10538155825, 5257.290265814105, 5261.76322065508, 5263.605229607795, 5283.181106928394, 4666.673332866701, 4680.648951328664, 4688.085823264465, 4689.788959496796, 4702.835400760991, 5696.857578560528, 5707.1724599933195, 5711.485966263056, 5718.42815718429, 5719.571032172562, 3817.4273858921106, 3821.312163810513, 3824.521934758155, 3829.8468061277517, 3834.7699138051807, 5862.325832529228, 5894.263217097863, 5912.201852749867, 5941.584089113807, 6001.909971350433, 3864.8260828262796, 3901.8634347798256, 3902.492675952108, 3911.5697273299916, 3935.8032098394965, 3989.4813674222164, 3996.220736956324, 4007.4189242559664, 4007.499062617173, 4010.8195131219163, 4576.336431217454, 4582.0377720679035, 4654.255319148988, 4665.183592871234, 4665.6734028617675, 5389.245505629215, 5551.500364967173, 5551.722413879371, 5648.406917273709, 5663.0, 1381.1367895065584, 1402.0746307437043, 1403.0669604712955, 1403.8876889848787, 1407.183833376639, 905.8369493491235, 918.2470374293016, 925.3892430995511, 927.3693888156118, 929.1962452478557, 4836.540528649773, 4872.43966943806, 4937.456879743226, 4942.258661200849, 4947.826826061142, 5794.21778059965, 5799.333076696234, 5799.5070419014855, 5800.1589769484035, 5801.3328467225965, 4866.075445665383, 4919.114559379274, 4927.113119638428, 4927.507249275044, 4940.555350018516, 3091.2271932016997, 3106.4718997770433, 3148.6064241969752, 3179.6184457865206, 3188.091393952712, 5535.612507124462, 5603.943960560342, 5608.018596745554, 5617.269754931833, 5623.746931388097, 6118.908216376758, 6118.908216376758, 6123.755049797958, 6129.96935015331, 6133.355997620186, 5582.967151077064, 5602.999999999918, 5608.383077861432, 5610.102383618601, 5613.073842815971, 5761.942380576141, 5965.4929331005615, 5969.313528944227, 5971.850703732442, 5983.0, 5797.797077102281, 5838.94161058384, 5848.005839007464, 5851.590388672752, 5852.092925596539, 5617.129344951539, 5619.538919880779, 5631.49316561495, 5636.774529018958, 5636.88726225465, 3832.3293423651307, 3882.3205938960004, 3910.648041676263, 3930.9213815724097, 3935.3900145477496, 5750.166225897305, 5861.560382971209, 5938.346781854079, 5940.3168635605725, 5959.106134079922, 5568.55451563882, 5635.605507614428, 5645.520130788929, 5687.8862422752145, 5710.885782284248, 5633.0, 5641.153826925994, 5699.629524080921, 5709.400512946247, 5720.227769251098, 5454.127339625641, 5590.888182236414, 5591.412901645269, 5595.860103497445, 5596.1605759136455, 5720.799772007959, 5757.3954734753925, 5769.769209231752, 5777.2200752897825, 5778.913316300343, 5584.218209450762, 5594.272744543184, 5600.467955544217, 5602.13166959122, 5609.298837645294], "unit": "ms", "name": "prototype.html", "value": 4207.037226719969}, {"lowerIsBetter": false, "replicates": [766.321805202396, 770.3875419041862, 779.6062988190963, 791.2917938445091, 793.6269953122032, 11092.556297748091, 11365.488553015113, 11398.25911315764, 11406.657800265984, 11420.771584568303, 10648.254622176451, 11096.778064438706, 11279.661610151708, 11367.545298188063, 11401.771964560725, 802.1016461563057, 821.7534739578133, 821.8726097454904, 822.4859462835727, 822.9382796290272, 811.3468657730524, 814.2793627639552, 819.1562690428868, 819.5328662662284, 820.1675299570941, 848.8514509960763, 851.9701810436636, 856.2550580994543, 856.4689892266772, 861.8017855893148, 841.6212704283066, 845.2688424512813, 850.8255807559435, 851.4720873058682, 853.3045567862173, 631.0282165465178, 633.5121956093782, 633.7655067625009, 634.4733870887153, 635.3805040085925, 10956.945215273952, 11042.558297668083, 11055.613053543088, 11178.04986576142, 11257.831132533018, 11135.888641113566, 11185.552577896875, 11207.271527350696, 11252.0, 11391.487383067783, 9084.727458176265, 9243.168114869693, 9270.397424167408, 9345.626174952993, 9412.529373531295, 3122.750179985596, 3218.3241519280978, 3251.398491279121, 3258.2017405735746, 3274.787138835968, 33015.339693206, 33393.16517087068, 36897.63102368969, 37351.252974940624, 42495.787521062506, 8933.19601235892, 9078.0, 9372.250219982385, 9557.0, 9614.663486777928, 17186.828131718772, 17203.741943870853, 17230.569235768955, 17249.91375043117, 17268.827311726724, 6187.731515039406, 6199.039148931923, 6240.157578726814, 6265.467435267962, 6326.873462530723, 3255.3814775192636, 3331.8833840815455, 3332.9333413331597, 3337.4826901830256, 3415.55597772293, 2594.169865642976, 2610.6606141201523, 2638.8416694998364, 2642.828216165943, 2654.9601755973677, 466.6896513818341, 470.02938931107155, 476.8045101508365, 477.87575230440336, 480.3491269330077, 477.4144343579865, 536.5171345788822, 562.4094700564391, 605.0893405424896, 613.1814028272306, 7263.636818159071, 7486.663100160506, 7507.5870827103945, 7631.7328893489575, 7635.389168866588, 588.0444278048171, 596.4095545410013, 601.173386593434, 604.9909251361233, 605.2283338743138, 3549.0832772344042, 3612.7471077024356, 3622.0, 3686.870959516404, 3718.4236443351324, 45733.0, 46484.76757616258, 53543.0, 53854.46145538573, 54185.45814541883, 38373.424398634044, 38389.0, 38430.231395371935, 39642.0, 39805.402918956235, 34468.65531344654, 38980.6101938977, 40047.39928901069, 42197.78901105536, 42330.15339693189, 7285.890711639436, 7637.923620763943, 7990.240927111915, 8031.277185053374, 8037.0, 31590.0, 32070.0, 32739.508907366886, 32747.34505309928, 32752.0, 38585.614143859326, 41118.58881411267, 41245.58754412417, 41373.79313103415, 41531.1693766129, 10179.338343007681, 10215.233857460571, 10438.68683939483, 10470.790584188426, 10490.108340791117, 11557.88442115568, 11699.649010529698, 11701.005414539859, 11723.296602203895, 11742.647720568397, 10714.410707411167, 10927.56289748433, 10971.890281097407, 11300.830487542858, 11446.0, 10352.482375881025, 10625.203109766644, 10683.25217234786, 10764.784704306026, 10928.562857485611, 10869.67390978272, 10905.890941090487, 10907.345559266469, 10959.12327013821, 10989.670309890716, 9289.442633442015, 9298.209652179641, 9509.857352139861, 9710.6115755369, 9784.070513301225, 9076.591553379982, 9463.337566370288, 9491.430514169171, 9519.904800951901, 9608.75978100553], "unit": "ms", "name": "yui.html", "value": 5715.968632942105}], "name": "dromaeo_css", "value": 6351.674528457014}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 110.0, 113.0, 113.0, 112.0, 129.0, 113.0, 113.0, 112.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 114.1}, {"lowerIsBetter": true, "replicates": [157.0, 131.0, 161.0, 164.0, 133.0, 159.0, 161.0, 146.0, 171.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.6}, {"lowerIsBetter": true, "replicates": [164.0, 164.0, 164.0, 164.0, 161.0, 168.0, 168.0, 164.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.4}, {"lowerIsBetter": true, "replicates": [77.0, 73.0, 72.0, 75.0, 151.0, 75.0, 74.0, 73.0, 72.0, 157.0], "unit": "ms", "name": "audio-fft", "value": 89.9}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 145.0, 95.0, 95.0, 95.0, 136.0, 95.0, 97.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 108.0}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 112.0, 110.0, 111.0, 110.0, 110.0, 110.0, 112.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.6}, {"lowerIsBetter": true, "replicates": [148.0, 150.0, 150.0, 165.0, 151.0, 150.0, 148.0, 149.0, 149.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 150.8}, {"lowerIsBetter": true, "replicates": [97.0, 98.0, 96.0, 96.0, 96.0, 97.0, 98.0, 96.0, 102.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 72.0, 72.0, 78.0, 73.0, 75.0, 85.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.7}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 69.0, 68.0, 69.0, 67.0, 69.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [85.0, 82.0, 84.0, 86.0, 87.0, 84.0, 86.0, 85.0, 96.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.1}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 133.0, 136.0, 129.0, 124.0, 123.0, 127.0, 126.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 127.1}, {"lowerIsBetter": true, "replicates": [134.0, 146.0, 135.0, 149.0, 147.0, 134.0, 145.0, 137.0, 137.0, 137.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 140.1}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 68.0, 71.0, 72.0, 70.0, 68.0, 70.0, 69.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.9}], "name": "kraken", "value": 1553.0}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.2800267648043], "unit": "score", "name": "Richards", "value": 211.03535600000004}, {"lowerIsBetter": false, "replicates": [183.3180568285976], "unit": "score", "name": "DeltaBlue", "value": 360.67369}, {"lowerIsBetter": false, "replicates": [277.9321845469705], "unit": "score", "name": "Encrypt", "value": 957.7192379999997}, {"lowerIsBetter": false, "replicates": [5256.544502617801], "unit": "score", "name": "Decrypt", "value": 50.6380189243028}, {"lowerIsBetter": false, "replicates": [1085.6832971800434], "unit": "score", "name": "RayTrace", "value": 681.5882697302699}, {"lowerIsBetter": false, "replicates": [713.7758743754462], "unit": "score", "name": "Earley", "value": 933.7146630000002}, {"lowerIsBetter": false, "replicates": [12108.43373493976], "unit": "score", "name": "Boyer", "value": 55.0412228855721}, {"lowerIsBetter": false, "replicates": [25550.0], "unit": "score", "name": "RegExp", "value": 35.65499021526421}, {"lowerIsBetter": false, "replicates": [602.4096385542168], "unit": "score", "name": "Splay", "value": 135.27506}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 21378.78401826701}]} 04:36:51 INFO - RETURN: dromaeo_css: 6351.67 04:36:51 INFO - RETURN: kraken: 1553.00 04:36:51 INFO - RETURN: v8_7: 21378.78 04:36:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21378.78"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1553.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6351.67"}}} 04:36:51 INFO - Return code: 0 04:36:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:36:51 INFO - # TBPL SUCCESS # 04:36:51 INFO - Running post-action listener: _resource_record_post_action 04:36:51 INFO - Running post-run listener: _resource_record_post_run 04:36:52 INFO - Total resource usage - Wall time: 1235s; CPU: 13.0%; Read bytes: 10375168; Write bytes: 397283328; Read time: 3400; Write time: 274812 04:36:52 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 483328; Read time: 0; Write time: 52 04:36:52 INFO - run-tests - Wall time: 1221s; CPU: 13.0%; Read bytes: 8638464; Write bytes: 336773120; Read time: 3224; Write time: 250012 04:36:52 INFO - Running post-run listener: _upload_blobber_files 04:36:52 INFO - Blob upload gear active. 04:36:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:36:52 INFO - Copying logs to upload dir... 04:36:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.232251 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-07 04:36:52.847161) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 04:36:52.850854) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009799 build_url: 'https://queue.taskcluster.net/v1/task/cS5qahOKSkCvE6pQjy5WVw/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-07 04:36:52.906120) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:36:52.906869) ========= 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=70a720fcaf18edea6683c2dc000001ad-1449465886.830900-618933789 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004472 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 04:36:52.961268) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 04:36:52.962049) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 04:36:52.962788) ========= ========= Total master_lag: 0.26 =========