builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-002 starttime: 1449663204.7 results: success (0) buildid: 20151209025641 builduid: a31111ab98084482b38f049fc212148d revision: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.696358) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.696862) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.697189) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006278 basedir: '/builds/slave/test' ========= master_lag: 0.04 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.746456) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.746771) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.768381) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.768692) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.027957 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.825705) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.826059) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.826458) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.826774) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 04:13: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.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 218M=0s 2015-12-09 04:13:25 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.139087 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.979392) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:24.979767) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.087819 ========= master_lag: 0.01 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.077747) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.078122) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 --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 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 --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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 04:13:25,285 truncating revision to first 12 chars 2015-12-09 04:13:25,285 Setting DEBUG logging. 2015-12-09 04:13:25,285 attempt 1/10 2015-12-09 04:13:25,285 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/40b58759c962?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 04:13:25,503 unpacking tar archive at: mozilla-central-40b58759c962/testing/mozharness/ program finished with exit code 0 elapsedTime=0.497246 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.588753) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.589102) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.598445) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.598745) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 04:13:25.599176) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-09 04:13:25.599515) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 04:13:25 INFO - MultiFileLogger online at 20151209 04:13:25 in /builds/slave/test 04:13:25 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 04:13:25 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:13:25 INFO - {'append_to_log': False, 04:13:25 INFO - 'base_work_dir': '/builds/slave/test', 04:13:25 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 04:13:25 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:13:25 INFO - 'branch': 'Firefox-Non-PGO', 04:13:25 INFO - 'buildbot_json_path': 'buildprops.json', 04:13:25 INFO - 'config_files': ('talos/linux_config.py',), 04:13:25 INFO - 'default_actions': ('clobber', 04:13:25 INFO - 'read-buildbot-config', 04:13:25 INFO - 'download-and-extract', 04:13:25 INFO - 'populate-webroot', 04:13:25 INFO - 'create-virtualenv', 04:13:25 INFO - 'install', 04:13:25 INFO - 'run-tests'), 04:13:25 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:13:25 INFO - 'download_minidump_stackwalk': True, 04:13:25 INFO - 'download_symbols': 'ondemand', 04:13:25 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:13:25 INFO - 'tooltool.py': '/tools/tooltool.py', 04:13:25 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:13:25 INFO - '/tools/misc-python/virtualenv.py')}, 04:13:25 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:13:25 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:13:25 INFO - 'installer_path': 'installer.exe', 04:13:25 INFO - 'log_level': 'info', 04:13:25 INFO - 'log_name': 'talos', 04:13:25 INFO - 'log_to_console': True, 04:13:25 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 04:13:25 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 04:13:25 INFO - 'opt_config_files': (), 04:13:25 INFO - 'pip_index': False, 04:13:25 INFO - 'sps_profile': False, 04:13:25 INFO - 'sps_profile_interval': 0, 04:13:25 INFO - 'suite': 'dromaeojs', 04:13:25 INFO - 'system_bits': '64', 04:13:25 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:13:25 INFO - 'title': 'talos-linux64-ix-002', 04:13:25 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:13:25 INFO - 'use_talos_json': True, 04:13:25 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:13:25 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:13:25 INFO - 'work_dir': 'build'} 04:13:25 INFO - ##### 04:13:25 INFO - ##### Running clobber step. 04:13:25 INFO - ##### 04:13:25 INFO - Running pre-action listener: _resource_record_pre_action 04:13:25 INFO - Running main action method: clobber 04:13:25 INFO - rmtree: /builds/slave/test/build 04:13:25 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:13:30 INFO - Running post-action listener: _resource_record_post_action 04:13:30 INFO - ##### 04:13:30 INFO - ##### Running read-buildbot-config step. 04:13:30 INFO - ##### 04:13:30 INFO - Running pre-action listener: _resource_record_pre_action 04:13:30 INFO - Running main action method: read_buildbot_config 04:13:30 INFO - Using buildbot properties: 04:13:30 INFO - { 04:13:30 INFO - "properties": { 04:13:30 INFO - "buildnumber": 235, 04:13:30 INFO - "product": "firefox", 04:13:30 INFO - "script_repo_revision": "production", 04:13:30 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 04:13:30 INFO - "repository": "", 04:13:30 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 04:13:30 INFO - "buildid": "20151209025641", 04:13:30 INFO - "slavename": "talos-linux64-ix-002", 04:13:30 INFO - "pgo_build": "False", 04:13:30 INFO - "basedir": "/builds/slave/test", 04:13:30 INFO - "project": "", 04:13:30 INFO - "platform": "ubuntu64_hw", 04:13:30 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 04:13:30 INFO - "slavebuilddir": "test", 04:13:30 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 04:13:30 INFO - "branch": "mozilla-central", 04:13:30 INFO - "repo_path": "mozilla-central", 04:13:30 INFO - "stage_platform": "linux64", 04:13:30 INFO - "builduid": "a31111ab98084482b38f049fc212148d", 04:13:30 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:30 INFO - }, 04:13:30 INFO - "sourcestamp": { 04:13:30 INFO - "repository": "", 04:13:30 INFO - "hasPatch": false, 04:13:30 INFO - "project": "", 04:13:30 INFO - "branch": "mozilla-central-linux64-talos", 04:13:30 INFO - "changes": [ 04:13:30 INFO - { 04:13:30 INFO - "category": null, 04:13:30 INFO - "files": [ 04:13:30 INFO - { 04:13:30 INFO - "url": null, 04:13:30 INFO - "name": "https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 04:13:30 INFO - } 04:13:30 INFO - ], 04:13:30 INFO - "repository": "", 04:13:30 INFO - "rev": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50", 04:13:30 INFO - "who": "cbook@mozilla.com", 04:13:30 INFO - "when": 1449663157, 04:13:30 INFO - "number": 7145613, 04:13:30 INFO - "comments": "merge fx-team to mozilla-central a=merge", 04:13:30 INFO - "project": "", 04:13:30 INFO - "at": "Wed 09 Dec 2015 04:12:37", 04:13:30 INFO - "branch": "mozilla-central-linux64-talos", 04:13:30 INFO - "revlink": "", 04:13:30 INFO - "properties": [ 04:13:30 INFO - [ 04:13:30 INFO - "buildid", 04:13:30 INFO - "20151209025641", 04:13:30 INFO - "Change" 04:13:30 INFO - ], 04:13:30 INFO - [ 04:13:30 INFO - "builduid", 04:13:30 INFO - "a31111ab98084482b38f049fc212148d", 04:13:30 INFO - "Change" 04:13:30 INFO - ], 04:13:30 INFO - [ 04:13:30 INFO - "pgo_build", 04:13:30 INFO - "False", 04:13:30 INFO - "Change" 04:13:30 INFO - ] 04:13:30 INFO - ], 04:13:30 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:30 INFO - } 04:13:30 INFO - ], 04:13:30 INFO - "revision": "40b58759c962bf1a8dbf8b56a7227778dfdcfa50" 04:13:30 INFO - } 04:13:30 INFO - } 04:13:30 INFO - Found installer url https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 04:13:30 INFO - Running post-action listener: _resource_record_post_action 04:13:30 INFO - ##### 04:13:30 INFO - ##### Running download-and-extract step. 04:13:30 INFO - ##### 04:13:30 INFO - Running pre-action listener: _resource_record_pre_action 04:13:30 INFO - Running main action method: download_and_extract 04:13:30 INFO - mkdir: /builds/slave/test/build/tests 04:13: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:13:30 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:13:30 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json 04:13:30 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json 04:13:30 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:13:30 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:13:35 INFO - Downloaded 1302 bytes. 04:13:35 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:13:35 INFO - Using the following test package requirements: 04:13:35 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 04:13:35 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'jsshell-linux-x86_64.zip'], 04:13:35 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 04:13:35 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 04:13:35 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 04:13:35 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 04:13:35 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 04:13:35 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 04:13:35 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 04:13:35 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 04:13: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:13:35 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:48 INFO - Downloaded 21859522 bytes. 04:13:48 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:13:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:48 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:13:49 INFO - Return code: 0 04:13:49 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:13:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:49 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 04:13:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:50 INFO - Downloaded 21859522 bytes. 04:13:50 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:13:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 04:13:50 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:13:51 INFO - Return code: 0 04:13:51 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:13:51 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 04:13:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:52 INFO - Downloaded 11132038 bytes. 04:13:52 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:13:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 04:13:52 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:13:52 INFO - Return code: 0 04:13:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:52 INFO - https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 04:13:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/TmOKfccUSS6dZTBIdP6Jjg/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:13:55 INFO - Downloaded 57731950 bytes. 04:13:55 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:55 INFO - mkdir: /builds/slave/test/properties 04:13:55 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:13:55 INFO - Writing to file /builds/slave/test/properties/build_url 04:13:55 INFO - Contents: 04:13:55 INFO - build_url:https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 04:13:55 INFO - Running post-action listener: _resource_record_post_action 04:13:55 INFO - Running post-action listener: set_extra_try_arguments 04:13:55 INFO - ##### 04:13:55 INFO - ##### Running populate-webroot step. 04:13:55 INFO - ##### 04:13:55 INFO - Running pre-action listener: _resource_record_pre_action 04:13:55 INFO - Running main action method: populate_webroot 04:13:55 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:13:55 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:13:55 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:13:55 INFO - '--tppagecycles', 04:13:55 INFO - '7'], 04:13:55 INFO - 'tests': ['tsvgm']}}, 04:13:55 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:13:55 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:13:55 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:55 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 04:13:55 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:55 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:13:55 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'tests': ['damp', 'tps']}, 04:13:55 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['damp', 'tps']}, 04:13:55 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:13:55 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:13:55 INFO - 'other': {'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'other_l64': {'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'other_nol64': {'tests': ['a11yr', 04:13:55 INFO - 'ts_paint', 04:13:55 INFO - 'tpaint', 04:13:55 INFO - 'sessionrestore', 04:13:55 INFO - 'sessionrestore_no_auto_restore']}, 04:13:55 INFO - 'svgr': {'tests': ['tsvgx', 04:13:55 INFO - 'tsvgr_opacity', 04:13:55 INFO - 'tart', 04:13:55 INFO - 'tscrollx', 04:13:55 INFO - 'cart']}, 04:13:55 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['tsvgx', 04:13:55 INFO - 'tsvgr_opacity', 04:13:55 INFO - 'tart', 04:13:55 INFO - 'tscrollx', 04:13:55 INFO - 'cart']}, 04:13:55 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'tests': ['tp5o']}, 04:13:55 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'talos_options': ['--e10s'], 04:13:55 INFO - 'tests': ['tp5o']}, 04:13:55 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'talos_options': ['--xperf_path', 04:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:55 INFO - 'tests': ['tp5n']}, 04:13:55 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:13:55 INFO - 'talos_options': ['--e10s', 04:13:55 INFO - '--xperf_path', 04:13:55 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:13:55 INFO - 'tests': ['tp5n']}}, 04:13:55 INFO - 'talos.zip': {'path': '', 04:13:55 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:13:55 INFO - Running post-action listener: _resource_record_post_action 04:13:55 INFO - ##### 04:13:55 INFO - ##### Running create-virtualenv step. 04:13:55 INFO - ##### 04:13:55 INFO - Running pre-action listener: _resource_record_pre_action 04:13:55 INFO - Running main action method: create_virtualenv 04:13:55 INFO - Creating virtualenv /builds/slave/test/build/venv 04:13:55 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:13:55 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:13:55 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:13:55 INFO - Using real prefix '/usr' 04:13:55 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:13:55 INFO - Installing distribute.............................................................................................................................................................................................done. 04:13:57 INFO - Installing pip.................done. 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:57 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:13:57 INFO - Cleaning up... 04:13:57 INFO - Return code: 0 04:13:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:13:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:13:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:13:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:13:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:13:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:13:57 INFO - Using env: {'DISPLAY': ':0', 04:13:57 INFO - 'HOME': '/home/cltbld', 04:13:57 INFO - 'LANG': 'en_US.UTF-8', 04:13:57 INFO - 'LANGUAGE': 'en_US:en', 04:13:57 INFO - 'LOGNAME': 'cltbld', 04:13:57 INFO - 'MAIL': '/var/mail/cltbld', 04:13:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:13:57 INFO - 'MOZ_NO_REMOTE': '1', 04:13:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:13:57 INFO - 'NO_EM_RESTART': '1', 04:13:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:13:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:13:57 INFO - 'PWD': '/builds/slave/test', 04:13:57 INFO - 'SHELL': '/bin/bash', 04:13:57 INFO - 'SHLVL': '1', 04:13:57 INFO - 'TERM': 'linux', 04:13:57 INFO - 'TMOUT': '86400', 04:13:57 INFO - 'USER': 'cltbld', 04:13:57 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:13:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:13:57 INFO - '_': '/tools/buildbot/bin/python'} 04:13:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:13:58 INFO - Downloading/unpacking psutil>=0.7.1 04:13: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:13: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:13: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:13: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:13: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:13: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:13:59 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 04:13:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 04:13:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:13:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:13:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:13:59 INFO - Installing collected packages: psutil 04:13:59 INFO - Running setup.py install for psutil 04:14:00 INFO - building 'psutil._psutil_linux' extension 04:14:00 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:14:00 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:14:00 INFO - building 'psutil._psutil_posix' extension 04:14:00 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:14:00 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:14:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:14:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:14:00 INFO - Successfully installed psutil 04:14:00 INFO - Cleaning up... 04:14:00 INFO - Return code: 0 04:14:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:00 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:00 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:14:00 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:14:00 INFO - Using env: {'DISPLAY': ':0', 04:14:00 INFO - 'HOME': '/home/cltbld', 04:14:00 INFO - 'LANG': 'en_US.UTF-8', 04:14:00 INFO - 'LANGUAGE': 'en_US:en', 04:14:00 INFO - 'LOGNAME': 'cltbld', 04:14:00 INFO - 'MAIL': '/var/mail/cltbld', 04:14:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:00 INFO - 'MOZ_NO_REMOTE': '1', 04:14:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:00 INFO - 'NO_EM_RESTART': '1', 04:14:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:00 INFO - 'PWD': '/builds/slave/test', 04:14:00 INFO - 'SHELL': '/bin/bash', 04:14:00 INFO - 'SHLVL': '1', 04:14:00 INFO - 'TERM': 'linux', 04:14:00 INFO - 'TMOUT': '86400', 04:14:00 INFO - 'USER': 'cltbld', 04:14:00 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:00 INFO - '_': '/tools/buildbot/bin/python'} 04:14:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:14:00 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:14:00 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:14:00 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:14:00 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:14:00 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:14:00 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:14:02 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:14:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 04:14:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:14:02 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:14:02 INFO - Installing collected packages: mozsystemmonitor 04:14:02 INFO - Running setup.py install for mozsystemmonitor 04:14:02 INFO - Successfully installed mozsystemmonitor 04:14:02 INFO - Cleaning up... 04:14:02 INFO - Return code: 0 04:14:02 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:02 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:02 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:14:02 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:14:02 INFO - Using env: {'DISPLAY': ':0', 04:14:02 INFO - 'HOME': '/home/cltbld', 04:14:02 INFO - 'LANG': 'en_US.UTF-8', 04:14:02 INFO - 'LANGUAGE': 'en_US:en', 04:14:02 INFO - 'LOGNAME': 'cltbld', 04:14:02 INFO - 'MAIL': '/var/mail/cltbld', 04:14:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:02 INFO - 'MOZ_NO_REMOTE': '1', 04:14:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:02 INFO - 'NO_EM_RESTART': '1', 04:14:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:02 INFO - 'PWD': '/builds/slave/test', 04:14:02 INFO - 'SHELL': '/bin/bash', 04:14:02 INFO - 'SHLVL': '1', 04:14:02 INFO - 'TERM': 'linux', 04:14:02 INFO - 'TMOUT': '86400', 04:14:02 INFO - 'USER': 'cltbld', 04:14:02 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:02 INFO - '_': '/tools/buildbot/bin/python'} 04:14:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:02 INFO - Downloading/unpacking blobuploader==1.2.4 04:14:02 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:14:02 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:14:02 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:14:02 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:14:02 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:14:02 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:14:04 INFO - Downloading blobuploader-1.2.4.tar.gz 04:14:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:14:04 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 04:14:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:14:04 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:05 INFO - Downloading docopt-0.6.1.tar.gz 04:14:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 04:14:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:14:05 INFO - Installing collected packages: blobuploader, requests, docopt 04:14:05 INFO - Running setup.py install for blobuploader 04:14:05 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:14:05 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:14:05 INFO - Running setup.py install for requests 04:14:05 INFO - Running setup.py install for docopt 04:14:05 INFO - Successfully installed blobuploader requests docopt 04:14:05 INFO - Cleaning up... 04:14:05 INFO - Return code: 0 04:14:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:05 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:05 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:14:05 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:14:05 INFO - Using env: {'DISPLAY': ':0', 04:14:05 INFO - 'HOME': '/home/cltbld', 04:14:05 INFO - 'LANG': 'en_US.UTF-8', 04:14:05 INFO - 'LANGUAGE': 'en_US:en', 04:14:05 INFO - 'LOGNAME': 'cltbld', 04:14:05 INFO - 'MAIL': '/var/mail/cltbld', 04:14:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:05 INFO - 'MOZ_NO_REMOTE': '1', 04:14:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:05 INFO - 'NO_EM_RESTART': '1', 04:14:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:05 INFO - 'PWD': '/builds/slave/test', 04:14:05 INFO - 'SHELL': '/bin/bash', 04:14:05 INFO - 'SHLVL': '1', 04:14:05 INFO - 'TERM': 'linux', 04:14:05 INFO - 'TMOUT': '86400', 04:14:05 INFO - 'USER': 'cltbld', 04:14:05 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:05 INFO - '_': '/tools/buildbot/bin/python'} 04:14:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:06 INFO - Running setup.py (path:/tmp/pip-ybZIt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:06 INFO - Running setup.py (path:/tmp/pip-STaWWh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:06 INFO - Running setup.py (path:/tmp/pip-xD9Cln-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:06 INFO - Running setup.py (path:/tmp/pip-tPuYNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:06 INFO - Running setup.py (path:/tmp/pip-fn3l9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:06 INFO - Running setup.py (path:/tmp/pip-2KggLw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:06 INFO - Running setup.py (path:/tmp/pip-Y__otS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:06 INFO - Running setup.py (path:/tmp/pip-F_2tZ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:06 INFO - Running setup.py (path:/tmp/pip-IB4ozn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:06 INFO - Running setup.py (path:/tmp/pip-ZeqTCi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:06 INFO - Running setup.py (path:/tmp/pip-xsdqSJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:06 INFO - Running setup.py (path:/tmp/pip-R1IXby-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:06 INFO - Running setup.py (path:/tmp/pip-TEmrIt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:06 INFO - Running setup.py (path:/tmp/pip-Cdo75m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:07 INFO - Running setup.py (path:/tmp/pip-cNfiSg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:07 INFO - Running setup.py (path:/tmp/pip-aJfDOh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:07 INFO - Running setup.py (path:/tmp/pip-H_rVuu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:07 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:14:07 INFO - Running setup.py install for manifestparser 04:14:07 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Running setup.py install for mozcrash 04:14:07 INFO - Running setup.py install for mozdebug 04:14:07 INFO - Running setup.py install for mozdevice 04:14:07 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Running setup.py install for mozfile 04:14:07 INFO - Running setup.py install for mozhttpd 04:14:07 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Running setup.py install for mozinfo 04:14:07 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:14:07 INFO - Running setup.py install for mozInstall 04:14:08 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for mozleak 04:14:08 INFO - Running setup.py install for mozlog 04:14:08 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for moznetwork 04:14:08 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for mozprocess 04:14:08 INFO - Running setup.py install for mozprofile 04:14:08 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for mozrunner 04:14:08 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Running setup.py install for mozscreenshot 04:14:08 INFO - Running setup.py install for moztest 04:14:08 INFO - Running setup.py install for mozversion 04:14:08 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:14:08 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:14:08 INFO - Cleaning up... 04:14:08 INFO - Return code: 0 04:14:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:08 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:08 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:14:08 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:14:09 INFO - Using env: {'DISPLAY': ':0', 04:14:09 INFO - 'HOME': '/home/cltbld', 04:14:09 INFO - 'LANG': 'en_US.UTF-8', 04:14:09 INFO - 'LANGUAGE': 'en_US:en', 04:14:09 INFO - 'LOGNAME': 'cltbld', 04:14:09 INFO - 'MAIL': '/var/mail/cltbld', 04:14:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:09 INFO - 'MOZ_NO_REMOTE': '1', 04:14:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:09 INFO - 'NO_EM_RESTART': '1', 04:14:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:09 INFO - 'PWD': '/builds/slave/test', 04:14:09 INFO - 'SHELL': '/bin/bash', 04:14:09 INFO - 'SHLVL': '1', 04:14:09 INFO - 'TERM': 'linux', 04:14:09 INFO - 'TMOUT': '86400', 04:14:09 INFO - 'USER': 'cltbld', 04:14:09 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:09 INFO - '_': '/tools/buildbot/bin/python'} 04:14:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:14:09 INFO - Running setup.py (path:/tmp/pip-Nu4N10-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:14:09 INFO - Running setup.py (path:/tmp/pip-p3ADIR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:14:09 INFO - Running setup.py (path:/tmp/pip-0oAv03-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:14:09 INFO - Running setup.py (path:/tmp/pip-I319WZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:14:09 INFO - Running setup.py (path:/tmp/pip-_BQS6Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:14:09 INFO - Running setup.py (path:/tmp/pip-7BLdX1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:14:09 INFO - Running setup.py (path:/tmp/pip-H_diul-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:14:09 INFO - Running setup.py (path:/tmp/pip-IRCVNQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:14:09 INFO - Running setup.py (path:/tmp/pip-2HMyUb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:14:09 INFO - Running setup.py (path:/tmp/pip-6bl2kO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:14:09 INFO - Running setup.py (path:/tmp/pip-8ZQOwr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:14:09 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:14:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:14:10 INFO - Running setup.py (path:/tmp/pip-DrsXeT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:14:10 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:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:14:10 INFO - Running setup.py (path:/tmp/pip-GHrXFv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:14:10 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:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:14:10 INFO - Running setup.py (path:/tmp/pip-6RhrqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:14:10 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:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:10 INFO - Running setup.py (path:/tmp/pip-hRD0qM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:14:10 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:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:14:10 INFO - Running setup.py (path:/tmp/pip-0927Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:14:10 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:14:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:14:10 INFO - Running setup.py (path:/tmp/pip-FQrj8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:14:10 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:14:10 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:14:10 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:14:10 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:14:10 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:14:10 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:14:10 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:14:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:14:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:14:12 INFO - Downloading blessings-1.5.1.tar.gz 04:14:12 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:14:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:14:12 INFO - Installing collected packages: blessings 04:14:12 INFO - Running setup.py install for blessings 04:14:12 INFO - Successfully installed blessings 04:14:12 INFO - Cleaning up... 04:14:12 INFO - Return code: 0 04:14:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:14:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:12 INFO - Reading from file tmpfile_stdout 04:14:12 INFO - Current package versions: 04:14:12 INFO - argparse == 1.2.1 04:14:12 INFO - blessings == 1.5.1 04:14:12 INFO - blobuploader == 1.2.4 04:14:12 INFO - docopt == 0.6.1 04:14:12 INFO - manifestparser == 1.1 04:14:12 INFO - mozInstall == 1.12 04:14:12 INFO - mozcrash == 0.16 04:14:12 INFO - mozdebug == 0.1 04:14:12 INFO - mozdevice == 0.47 04:14:12 INFO - mozfile == 1.2 04:14:12 INFO - mozhttpd == 0.7 04:14:12 INFO - mozinfo == 0.9 04:14:12 INFO - mozleak == 0.1 04:14:12 INFO - mozlog == 3.1 04:14:12 INFO - moznetwork == 0.27 04:14:12 INFO - mozprocess == 0.22 04:14:12 INFO - mozprofile == 0.27 04:14:12 INFO - mozrunner == 6.11 04:14:12 INFO - mozscreenshot == 0.1 04:14:12 INFO - mozsystemmonitor == 0.0 04:14:12 INFO - moztest == 0.7 04:14:12 INFO - mozversion == 1.4 04:14:12 INFO - psutil == 3.1.1 04:14:12 INFO - requests == 1.2.3 04:14:12 INFO - wsgiref == 0.1.2 04:14:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:12 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:12 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:14:12 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:14:12 INFO - Using env: {'DISPLAY': ':0', 04:14:12 INFO - 'HOME': '/home/cltbld', 04:14:12 INFO - 'LANG': 'en_US.UTF-8', 04:14:12 INFO - 'LANGUAGE': 'en_US:en', 04:14:12 INFO - 'LOGNAME': 'cltbld', 04:14:12 INFO - 'MAIL': '/var/mail/cltbld', 04:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:12 INFO - 'MOZ_NO_REMOTE': '1', 04:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:12 INFO - 'NO_EM_RESTART': '1', 04:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:12 INFO - 'PWD': '/builds/slave/test', 04:14:12 INFO - 'SHELL': '/bin/bash', 04:14:12 INFO - 'SHLVL': '1', 04:14:12 INFO - 'TERM': 'linux', 04:14:12 INFO - 'TMOUT': '86400', 04:14:12 INFO - 'USER': 'cltbld', 04:14:12 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:12 INFO - '_': '/tools/buildbot/bin/python'} 04:14:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 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:14:12 INFO - Cleaning up... 04:14:12 INFO - Return code: 0 04:14:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:12 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:12 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:14:12 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:14:12 INFO - Using env: {'DISPLAY': ':0', 04:14:12 INFO - 'HOME': '/home/cltbld', 04:14:12 INFO - 'LANG': 'en_US.UTF-8', 04:14:12 INFO - 'LANGUAGE': 'en_US:en', 04:14:12 INFO - 'LOGNAME': 'cltbld', 04:14:12 INFO - 'MAIL': '/var/mail/cltbld', 04:14:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:12 INFO - 'MOZ_NO_REMOTE': '1', 04:14:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:12 INFO - 'NO_EM_RESTART': '1', 04:14:12 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:12 INFO - 'PWD': '/builds/slave/test', 04:14:12 INFO - 'SHELL': '/bin/bash', 04:14:12 INFO - 'SHLVL': '1', 04:14:12 INFO - 'TERM': 'linux', 04:14:12 INFO - 'TMOUT': '86400', 04:14:12 INFO - 'USER': 'cltbld', 04:14:12 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:12 INFO - '_': '/tools/buildbot/bin/python'} 04:14:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:13 INFO - Downloading/unpacking jsonschema 04:14: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:14: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:14: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:14: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:14: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:14: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:14:14 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:14:14 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:14:14 INFO - Downloading/unpacking functools32 (from jsonschema) 04:14: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:14: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:14: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:14: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:14: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:14: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:14:14 INFO - Downloading functools32-3.2.3-2.tar.gz 04:14:14 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:14:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:14:14 INFO - warning: no files found matching '*.txt' 04:14:14 INFO - no previously-included directories found matching 'build' 04:14:14 INFO - no previously-included directories found matching 'dist' 04:14:14 INFO - no previously-included directories found matching '.git*' 04:14:14 INFO - Installing collected packages: jsonschema, functools32 04:14:15 INFO - Running setup.py install for functools32 04:14:15 INFO - warning: no files found matching '*.txt' 04:14:15 INFO - no previously-included directories found matching 'build' 04:14:15 INFO - no previously-included directories found matching 'dist' 04:14:15 INFO - no previously-included directories found matching '.git*' 04:14:15 INFO - Successfully installed jsonschema functools32 04:14:15 INFO - Cleaning up... 04:14:15 INFO - Return code: 0 04:14:15 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:14:15 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:14:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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:14:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:14:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:14:15 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 0x7fcfd802ff10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xf768a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1044240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, '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': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', '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:14:15 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:14:15 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:14:15 INFO - Using env: {'DISPLAY': ':0', 04:14:15 INFO - 'HOME': '/home/cltbld', 04:14:15 INFO - 'LANG': 'en_US.UTF-8', 04:14:15 INFO - 'LANGUAGE': 'en_US:en', 04:14:15 INFO - 'LOGNAME': 'cltbld', 04:14:15 INFO - 'MAIL': '/var/mail/cltbld', 04:14:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:15 INFO - 'MOZ_NO_REMOTE': '1', 04:14:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:15 INFO - 'NO_EM_RESTART': '1', 04:14:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:15 INFO - 'PWD': '/builds/slave/test', 04:14:15 INFO - 'SHELL': '/bin/bash', 04:14:15 INFO - 'SHLVL': '1', 04:14:15 INFO - 'TERM': 'linux', 04:14:15 INFO - 'TMOUT': '86400', 04:14:15 INFO - 'USER': 'cltbld', 04:14:15 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:15 INFO - '_': '/tools/buildbot/bin/python'} 04:14:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:14:15 INFO - Downloading/unpacking flake8 04:14: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:14: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:14: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:14: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:14: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:14: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:14:17 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:14:17 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:14:17 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:14:17 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:14:17 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 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:14:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 04:14:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:17 INFO - no previously-included directories found matching 'docs/_build' 04:14:17 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:14:17 INFO - Running setup.py install for pep8 04:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:14:17 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:14:17 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:14:17 INFO - no previously-included directories found matching 'docs/_build' 04:14:17 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:14:17 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:14:17 INFO - Cleaning up... 04:14:17 INFO - Return code: 0 04:14:17 INFO - Running post-action listener: _resource_record_post_action 04:14:17 INFO - Running post-action listener: _start_resource_monitoring 04:14:17 INFO - Starting resource monitoring. 04:14:17 INFO - ##### 04:14:17 INFO - ##### Running install step. 04:14:17 INFO - ##### 04:14:17 INFO - Running pre-action listener: _resource_record_pre_action 04:14:17 INFO - Running main action method: install 04:14:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:14:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:14:18 INFO - Reading from file tmpfile_stdout 04:14:18 INFO - Detecting whether we're running mozinstall >=1.0... 04:14:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:14:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:14:18 INFO - Reading from file tmpfile_stdout 04:14:18 INFO - Output received: 04:14:18 INFO - Usage: mozinstall [options] installer 04:14:18 INFO - Options: 04:14:18 INFO - -h, --help show this help message and exit 04:14:18 INFO - -d DEST, --destination=DEST 04:14:18 INFO - Directory to install application into. [default: 04:14:18 INFO - "/builds/slave/test"] 04:14:18 INFO - --app=APP Application being installed. [default: firefox] 04:14:18 INFO - mkdir: /builds/slave/test/build/application 04:14:18 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:14:18 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:14:32 INFO - Reading from file tmpfile_stdout 04:14:32 INFO - Output received: 04:14:32 INFO - /builds/slave/test/build/application/firefox/firefox 04:14:32 INFO - Running post-action listener: _resource_record_post_action 04:14:32 INFO - ##### 04:14:32 INFO - ##### Running run-tests step. 04:14:32 INFO - ##### 04:14:32 INFO - Running pre-action listener: _resource_record_pre_action 04:14:32 INFO - Running main action method: run_tests 04:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:14:32 INFO - Python 2.7.3 04:14:32 INFO - Return code: 0 04:14:32 INFO - grabbing minidump binary from tooltool 04:14:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:14:32 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 0x10d30b0>, '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 0x10d3fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d4440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:14:32 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:14:32 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:14:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:14:32 INFO - Return code: 0 04:14:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 04:14:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:14:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:14:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 04:14:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:14:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:14:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:14:33 INFO - Return code: 0 04:14:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] in /builds/slave/test/build 04:14:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-002 --webServer localhost 04:14:33 INFO - Using env: {'DISPLAY': ':0', 04:14:33 INFO - 'HOME': '/home/cltbld', 04:14:33 INFO - 'LANG': 'en_US.UTF-8', 04:14:33 INFO - 'LANGUAGE': 'en_US:en', 04:14:33 INFO - 'LOGNAME': 'cltbld', 04:14:33 INFO - 'MAIL': '/var/mail/cltbld', 04:14:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:14:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 04:14:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:14:33 INFO - 'MOZ_NO_REMOTE': '1', 04:14:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:14:33 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 04:14:33 INFO - 'NO_EM_RESTART': '1', 04:14:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 04:14:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:14:33 INFO - 'PWD': '/builds/slave/test', 04:14:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:14:33 INFO - 'SHELL': '/bin/bash', 04:14:33 INFO - 'SHLVL': '1', 04:14:33 INFO - 'TERM': 'linux', 04:14:33 INFO - 'TMOUT': '86400', 04:14:33 INFO - 'USER': 'cltbld', 04:14:33 INFO - 'XDG_SESSION_COOKIE': 'dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004', 04:14:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:14:33 INFO - '_': '/tools/buildbot/bin/python'} 04:14:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-002', '--webServer', 'localhost'] with output_timeout 3600 04:14:33 INFO - mozversion INFO | application_buildid: 20151209025641 04:14:33 INFO - mozversion INFO | application_changeset: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 04:14:33 INFO - mozversion INFO | application_display_name: Nightly 04:14:33 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:14:33 INFO - mozversion INFO | application_name: Firefox 04:14:33 INFO - mozversion INFO | application_remotingname: firefox 04:14:33 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 04:14:33 INFO - mozversion INFO | application_vendor: Mozilla 04:14:33 INFO - mozversion INFO | application_version: 45.0a1 04:14:33 INFO - mozversion INFO | platform_buildid: 20151209025641 04:14:33 INFO - mozversion INFO | platform_changeset: 40b58759c962bf1a8dbf8b56a7227778dfdcfa50 04:14:33 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 04:14:33 INFO - mozversion INFO | platform_version: 45.0a1 04:14:33 INFO - 2015-12-09 04:14:33,985 DEBUG : using testdate: 1449663273 04:14:33 INFO - 2015-12-09 04:14:33,985 DEBUG : actual date: 1449663273 04:14:33 INFO - 2015-12-09 04:14:33,994 INFO : starting webserver on 'localhost:51117' 04:14:33 INFO - 2015-12-09 04:14:33,995 INFO : Starting test suite talos-linux64-ix-002 04:14:33 INFO - 2015-12-09 04:14:33,996 INFO : Starting test dromaeo_css 04:14:33 INFO - 2015-12-09 04:14:33,996 DEBUG : operating with platform_type : linux_ 04:14:33 INFO - 2015-12-09 04:14:33,997 INFO : Initialising browser for dromaeo_css test... 04:14:34 INFO - 2015-12-09 04:14:34,013 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpujrHGr/profile http://localhost:51117/getInfo.html 04:14:38 INFO - 2015-12-09 04:14:38,324 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:14:38 INFO - 2015-12-09 04:14:38,324 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:14:38 INFO - 2015-12-09 04:14:38,324 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:14:38 INFO - 2015-12-09 04:14:38,324 DEBUG : BROWSER_OUTPUT: __metrics 04:14:38 INFO - 2015-12-09 04:14:38,408 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:14:38 INFO - 2015-12-09 04:14:38,464 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:14:39 INFO - 2015-12-09 04:14:39,333 INFO : Browser initialized. 04:14:39 INFO - 2015-12-09 04:14:39,333 INFO : Running cycle 1/1 for dromaeo_css test... 04:14:39 INFO - 2015-12-09 04:14:39,334 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpujrHGr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:14:51 INFO - 2015-12-09 04:14:51,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 142577664 04:14:51 INFO - 2015-12-09 04:14:51,319 DEBUG : BROWSER_OUTPUT: 04:15:42 INFO - 2015-12-09 04:15:42,671 DEBUG : BROWSER_OUTPUT: 1449663342666 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:17:54 INFO - 2015-12-09 04:17:54,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51117/tests/dromaeo/cssquery-ext.html) 04:17:55 INFO - 2015-12-09 04:17:55,849 DEBUG : BROWSER_OUTPUT: RSS: Main: 236929024 04:17:55 INFO - 2015-12-09 04:17:55,849 DEBUG : BROWSER_OUTPUT: 04:20:58 INFO - 2015-12-09 04:20:58,386 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-ext.html (next: http://localhost:51117/tests/dromaeo/cssquery-jquery.html) 04:20:58 INFO - 2015-12-09 04:20:58,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 217190400 04:20:58 INFO - 2015-12-09 04:20:58,960 DEBUG : BROWSER_OUTPUT: 04:24:00 INFO - 2015-12-09 04:24:00,966 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51117/tests/dromaeo/cssquery-mootools.html) 04:24:01 INFO - 2015-12-09 04:24:01,535 DEBUG : BROWSER_OUTPUT: RSS: Main: 229548032 04:24:01 INFO - 2015-12-09 04:24:01,535 DEBUG : BROWSER_OUTPUT: 04:27:03 INFO - 2015-12-09 04:27:03,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51117/tests/dromaeo/cssquery-prototype.html) 04:27:04 INFO - 2015-12-09 04:27:04,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 203800576 04:27:04 INFO - 2015-12-09 04:27:04,016 DEBUG : BROWSER_OUTPUT: 04:30:06 INFO - 2015-12-09 04:30:06,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51117/tests/dromaeo/cssquery-yui.html) 04:30:07 INFO - 2015-12-09 04:30:07,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 208031744 04:30:07 INFO - 2015-12-09 04:30:07,236 DEBUG : BROWSER_OUTPUT: 04:33:09 INFO - 2015-12-09 04:33:09,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/dromaeo/cssquery-yui.html (next: http://localhost:51117/tests/dromaeo/cssquery-dojo.html) 04:33:10 INFO - 2015-12-09 04:33:10,011 DEBUG : BROWSER_OUTPUT: RSS: Main: 252182528 04:33:10 INFO - 2015-12-09 04:33:10,011 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,012 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:33:10 INFO - 2015-12-09 04:33:10,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:33:10 INFO - 2015-12-09 04:33:10,012 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:33:10 INFO - 2015-12-09 04:33:10,012 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:33:10 INFO - 2015-12-09 04:33:10,016 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2610.5301045811757;2683.6242925990377;2691.219546331563;2693.9057133000347;2706.742859428354;4474.08281302333;4599.724016559009;4661.720296782191;4708.058388322336;4708.693934894234;4593.931091033629;4597.701149425285;4678.157931572324;4686.601638860701;4715.245560710278;4292;4320.265554855667;4337.04584991303;4422.668299877506;4452;4367.388565600819;4410.603045725884;4432.246518091933;4436.66724995625;4475.977620111895;4170.124273902484;4242.236397448458;4265.616094551474;4288.335308027261;4347.239233134221;4323.048929235563;4345.760983145926;4355.063661312801;4359.542248063939;4380.3210502372185;4332.653387729006;4337.696361254713;4339.305711086211;4355.912881742379;4359.149965756678;4407.316865885793;4495.46054473462;4514.548545145492;4554.772261386917;4690.95309046912;5016.874578135539;5026;5027.044861476308;5031.647784655075;5077.162268225738;5044.470330615306;5048.72232027242;5052.8484145475695;5054.368203974504;5055.9241611375855;4571.725696458223;4614.676972611952;4689.062187562467;4698.271767875985;4713.717176969393;5099.056674515226;5122.103631864409;5126.6923984561045;5127.307813445137;5184.040952423814;4949.529794669501;4949.876253093701;4952.4304704959395;4957.429895562056;5003.674761140514;4816.783244753994;4868.756562171877;4908.705477671351;4915.3855768029;4927.039227350704;4965.180745177077;5032.446430892599;5032.572231360302;5039.3448851649055;5040.243963405445;5004.199328107486;5005.924911126336;5017.9462312913965;5027.120253955543;5044.621653376012;4089.2230476209425;4157.688173387008;4194.203101410722;4223.535411104776;4244.702870799076;3635.381985062546;3663.19409729859;3694.8891533254045;3710.128119891823;3731.7201209909367;4252.553481884358;4322.286822674287;4323.762193079411;4356.716813407118;4370.475542934868;4812.181929072066;4916.70499770015;4920.704757714549;5022.949770502249;5028.748562571856;4263.850765223202;4329.307310830252;4331.177076355482;4350.891227719332;4372.584604462571;4450.06548624786;4481.574250446202;4487.125010622963;4491.079328737601;4542.227821270392;4573.496915339377;4696.131215725101;4701.5298470154075;4758.1435341638835;4760.143174228534;4910.263460480956;4916.434610019894;4934.580560652241;5031.245313202902;5048.772805223847;4725.503822098768;4727.149113159664;4734.786934588021;4747.905041899212;4791.856244312677;4960.007998400407;4960.057589058068;4965.577925876197;4974.527419895104;5004.599632029356;4838.951610483991;4893.730844803427;4950.430700469492;4970.801167953241;5019.899602007867;4921.212605983025;4935.851924442272;4936.481669424658;4944.703317800943;4950.975245123751;4924;4935.580475659609;4940;4950.900981980412;4970.353853999101;4669.48635650085;4732.195526760528;4802.51974802517;4813.03739252158;4872.4153101628035;4891.63312751538;4916.901661966669;4920.6801557898625;4921.2864134700985;4941.65408421407;4811;4816.759162041954;4817.253325734517;4820;4862.82980095695 04:33:10 INFO - 2015-12-09 04:33:10,017 DEBUG : BROWSER_OUTPUT: |1;ext.html;537.001177809275;540.8566729816599;545.3428618514689;549.066586802436;556.3185098254638;26659.6001059984;27025.59461608075;27100.322491937688;34963.12592185197;35618;40725.79637101811;41255.38116928248;41327;41341.58658413415;41359.79320103395;7854.057513098436;8022.679092836309;8029.598520074002;8032.116467188634;8040.316573091294;7189.460790440712;7373.5575865448245;9900.306978511508;10153.898461015406;10195.949020254888;9961.402315861036;10027.749306267366;10113.797724045515;10140.290179687425;10148.49257537124;7164.892526612105;7352.485326027127;9930.361490354118;10033.397996120257;10035.899641003643;9985.850212246822;10310.7422314442;10316.226283028804;10349.275550711453;10359.689209323733;36756;37627.81186094052;37716.43425348622;37730;37800.62199378026;2751.614773931651;2872.353720412911;2895.9276018099504;2917.897873574436;3019.350839569481;26778;26832.731672683218;27200.047998320162;28937;30354;3433.6051354094348;3474.826258687081;3522.084258092889;3525.541679581638;3527.0829584308262;326838;329831.9999999976;330164;330283;330500;51396.74301628543;55109.724451378286;55895.72052139713;56001.43998560044;56005.439945600025;45313;64041.35958640354;66659;66746.33253667498;66802;13067;13204.801927971088;13241.470341186245;13248.337583120805;13271.137376070525;9573.234141268682;9609.183219426288;9656.75858103539;9665.226781857435;9682.515874206261;19242.134103965076;19471.610567788564;19499.707504387447;19520.90239548793;19541.51146221356;7395.741149059864;7613.847723045508;7631.1605723370385;7728.381729461629;7840.882386764203;819.5943008210974;869.8695195720693;897.3490113825891;916.7616419730919;919.3426699909596;26231.475370492484;26247.868760656074;26823.329416764736;27044.32389190286;27085.593716094274;846.3139369911428;850.1974027263948;948.4641177734558;972.1736523954582;987.0474991633108;11894.583689570823;12063;12099.57651482194;12106.092043096804;12154.33151176676;311383;315367;316023;316781;317672;47400.7629961848;47940;48024.51975480201;48046.5195348049;48065;1186.6736647422028;1236.9628911132681;1237.6472705279132;1241.1436109084702;1259.0619988108735;21446.356609301747;21736.36977226746;22331.44171395728;22408.551828963657;22543.66184507201;34697.479537806445;35197.120071998404;35365.1158721034;35376.29247414986;36178.4573231407;250466;250670;250778;250991;251886;24519.877400612884;25101.623475647513;28884.27789305284;29476;29627.703722962495;33117.33765324728;33118.5032224512;33177.668223318426;33408.665913340556;33967.830160850026;30419.847900760353;30478.390432191674;30835.383292334478;30980.69019309778;31168.376632467676;24451.510969780862;30642.846785765927;30935.845320773253;31234.21914452157;32124.518132227568;31433;31513.21216969594;31659.84170079227;31921.201969950936;38187.2362552753;27491.31271718223;28591.714082858904;30128.397432051675;30130.397392052473;30325.848370758005;23573.646395304426;23664.31225654749;23823.285301440985;23991.760082398952;24002.39994000094 04:33:10 INFO - 2015-12-09 04:33:10,018 DEBUG : BROWSER_OUTPUT: |2;jquery.html;261.3479368974409;264.6097006914801;269.63599141159426;276.0999142794489;284.8077547655332;10367.896321036787;15617.219139043045;16288.26702798374;16293.348266069373;16339.18304084797;14668.486602968898;14949.103053816778;15059.924700376483;15486.303116359762;15501.147436890966;5572.58205634578;5729.828105156831;5763.884722305552;5774.133879918004;5775.855603609902;5681.914771278434;5720.056190728525;5722.62802917809;5726.828195154152;5735.2544169257935;4088.7546747195115;4124.835006599732;5584.553235741131;5746.511546518551;6424.2290925089055;6579.638119903403;6589.604623722592;6596.736130554772;6624.933750662504;6626.072349871022;6185.103160041814;6371.789360021581;6380.872382552323;6387.265464471552;6391.137196478462;20125;20197.697034544493;20470.38588842322;20689.379318620464;20696;1704.4460550321196;1731.480555833245;1767.6199617082389;1841.2634946021565;1987.4137129546818;8500.319974402033;8684.044755076937;8690.739277821676;8818.735437936872;8863.069377715376;1674.8073971493313;1678.991605041967;1691.6532110917233;1732.7920649522011;1764.4442000769716;51391.48608513942;54557.45442545563;54854.45145548533;54865.451345486435;54958;9659.758506037406;9692.903070969342;9717.902820971842;9731.708048758548;9770;12045.277283363026;12070.758584828254;12070.939645301718;12086.456109475095;12100.092493063055;6836.760713375008;6907.7236910524025;6958.582485050913;7012.158540975116;7035.050268213828;6674.5327827052615;6739.696713647898;6760.290169532128;6768.2216545097945;6786.253512113663;4032.7983600819844;4033.9596604033586;4043.636072753466;4111.951452379624;4145.564715704868;1561.73450513413;1614.1687031178951;1616.0546080542779;1640.4832477769464;1710.803257625364;321.08810976825924;342.48456073609555;346.9011331770484;801.6352559585491;827.0943317067802;8739.169778870997;9033.41282816628;9035.774105647411;15415.691686166214;15746.133962631937;710.7583421636565;801.2908575910361;826.8098337382436;827.3670641958906;851.5231470376485;8301.501909885426;8431.451955622864;8624.698135565224;9203.815923681488;9551.522423878778;465512;466200;477002;483075;483679;69549.65225173841;73489.26510734932;73594;73952.26047739561;74099;1022.99488502557;1073.3398959639921;1077.4612693653173;1081.691717860406;1089.8528698625742;13879.195704558342;13889.722205556034;14496.565103046925;14688.310844253048;14734.336954837272;32711;32889.34221315608;32894.17764555905;33226.83386583148;33818.32363352768;40622.39066414065;41074.58925410827;41106.794466028674;42242;42530;7991.120976692443;8324.292435143081;8331.041930178108;8360.749177524684;8361.874571881548;9670.274729395464;9710.271729620166;10289.84565231537;15375.923120384774;15481;12979.545715899898;13252.271125088213;13364.665883352605;13391.723407020634;13479.32603369808;11860.881391185978;12220.45007974661;12260.632181034583;12524.686882828002;12902.80645790295;13379.665508362368;13527.458901644217;13553.796693049415;13748.037637365289;13994.37025333842;8038.196180381915;8047.436679432618;8059.153788852086;8289.751307460785;8465.661373545236;11589.24669896454;13187.208767473981;13203.273819939996;13351.465941362625;13851.86148138546 04:33:10 INFO - 2015-12-09 04:33:10,022 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1414.5261337451952;1537.454203757666;1539.276540026188;1566.0368873143018;1633.4609578838983;5932.436418540237;6771.796846094619;6973.6513174341335;6978.720851165947;6987.231404545502;6687.929931211007;6872.312768723138;6872.828179295508;6891.173059232887;6894.965525172367;1966.803319668036;1978.0406502846108;1987.592543528573;1989.3037436897116;1990.452625527984;2001.059502034049;2007.076744697441;2023.757149142105;2095.3818623506027;2098.779628139039;2011.668074767669;2032.573159636478;2058.4133521946246;2058.7014882841977;2060.608484387969;2034.7965203479682;2052.6305265052283;2056.0953180600486;2064.9881558036604;2068.2864411777914;2035.6335859545277;2059.6807494838176;2076.9480762980897;2077.8649387789897;2078.5011597216712;6836.179658441019;6898.379145876896;6899.827504312382;6909.378155965987;6915.239323674442;3897.2400381925536;3954.5649978502342;3954.683625309968;3956.960430395688;3968.8809335719975;2663.5471969765185;2675.2241849863517;2717.7825773938234;2731.085086496026;2734.4257705881787;786.4219798448136;804.1395706593947;851.5699571716306;852.6845067325067;1751.4132765523566;9031.32265080115;9172.266218702487;9190.310726695458;9221.446713197229;9231.90768092324;3523.806190659487;3540.8583656653445;3545.840437180333;3605.8737944171826;3781.300459414962;8241.50550966944;8247.463914845515;8257.05959099623;8268;8326.916730832614;4198.181354635817;4198.538160802309;4207.579242075829;4220.873373798791;4225.809838557272;3136.059182245317;3170.651228364878;3595.2989167112164;3805.6955443564448;3810.1617644118805;3331.3670402623907;3397.7621566490106;3400.387930172593;3420.3159368125976;3426.7258619310396;1056.8309070548676;1080.9675709728722;1085.2294870641933;1092.2463500184847;1095.4851219926622;1040.8282633365561;1062.4262898034974;1139.840422340873;1161.3322339654733;1163.8603367595774;6531.706073226716;6559.114519539897;6568.441682456949;6591.044298576776;6609.735610575619;1076.6447072466067;1108.130117857478;1123.168855047259;1135.2734250079955;1143.451143451148;4985.825496107619;5013.323201367769;5039.949600504021;5055.469175736494;5056.06462804375;7916.802079948047;8030.718924837603;8278.213569710868;8278.751637450887;8293.33653307734;8182.345412366996;8198;8243.340532757366;8251.463654862415;8254.669813207405;6548.869022619616;6684.431823294977;6734.393904548712;6794.76218332356;6825.1809782825385;6314.810555683337;6337.302896681269;6345.7144428499905;6354.23749150105;6372.394622510854;7507.099148102263;7583;7600.201978792147;7652.426068044808;7668.731594394169;7701.075870895528;7747.845043098993;7807;7846.646900889359;7847.764567062997;4978.178600530872;5045.419776725724;5827.388124246893;5909.674967876808;5910.940890591039;6393.808185754435;6494.870102597827;6503.544751867324;6534.901976470262;6548.967255163694;6009.188759517409;6071;6080.604760690541;6177.166082578794;6323.336049714714;5991.64050156992;6027.36712645166;6074.635521868702;6099.3290738017895;6114.633122012693;6163.722632481459;6348.333424990495;6379.585326953733;6384.968075159594;6388.93611063902;5616.1014237721765;5862.12068189775;5862.7654893805475;5865.090910908816;5866.120081987736;5860.413958604106;5929.110633405024;5934.228550288435;5961.970190149022;5986.132010858489 04:33:10 INFO - 2015-12-09 04:33:10,023 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.9861407622581;255.19994816251048;258.1674101024197;259.0467081141399;259.22620976385485;5290.497402746738;5313.149896016638;5319.441458646839;5344.4922732340465;5377.784888604451;4706.505816889228;5035.244713292998;5051.797928082881;5084.38987321521;5263.4472830515;3943.940840887382;3982.084120652252;3983.721139520235;3996.1807829395048;3997.240524300388;3980.3233450313373;3985.681145508367;3986.6013398660193;3988.9401658974994;3990.461287726149;3767.321882061228;3832.405977073558;3873.8063096845044;3911.8435262589464;3949.8617548385814;3943.2902077626018;3943.881683549498;3948.506436695413;3954.6440820326306;3955.1496428267915;3387.2040070583394;3391.7625766196375;3395.134240768613;3401.4557670772806;3405.9489107663403;5125.564327032207;5127.410347810012;5129.281900533928;5130.948690513084;5143.794248230066;4458.643308535309;4539.273716205391;4552.840650577214;4553.590176884063;4556.407667003268;5553.8333849984165;5556.027695153372;5558.749856256478;5561.833145005657;5567.47109024642;3716.684081853046;3719.7210209234145;3721.0511319613324;3723.4228694552116;3731.197792474631;5855.560832937546;5860.945029894618;5865.354810970833;5866.090755932837;5866.178734977064;3620.7827530347736;3810.580836108026;3811.0662887592716;3815.6756675682877;3817.7783109405277;3830.8467661293794;3835.1562656215588;3835.9642896417813;3837.2901013312626;3837.9808100959876;4511.436070491189;4513.751743654065;4515.029268707243;4518.480374756879;4519.593236608721;5589.35722391922;5598.076317407664;5599.188117722989;5600.467955544217;5603.047481928001;1316.0261406559268;1325.648703093681;1327.230206480239;1327.7543654423962;1328.103530117167;865.4244927123518;871.1419252036738;878.5255961780567;891.6522556203086;892.9374943754004;4912.926306105412;4914.0908931847725;4918.040982008545;4919.7540122993705;4920.065187614342;5820.941790582125;5827.854303642443;5832.329282132524;5832.3292821326095;5833.649981001154;4728.030753695484;4912.263160525878;4915.705057696549;4916.410030796327;4916.532929371704;3032.651245106797;3059.3728285701377;3143.0727935258697;3144.8427578621436;3153.716165545112;5475;5488.780448782084;5492.862678433071;5495.258140151029;5497.862553436116;6002.249718785152;6004.729787159588;6008.429199226067;6013.939860601338;6016.42843929826;5378.2470454136455;5450;5481.945180548223;5492.148716948959;5494.313210848644;5829.3296270927685;5853.853653658693;5861.120831875252;5864.413558644102;5864.912026319524;5716.657000579979;5721.57088218377;5728.341240757366;5734;5736.19693242938;5329.1206950852675;5482.068048431856;5483.177523371526;5485.149801780731;5485.670859748428;3753.793541355142;3783.2244389900557;3785.072657199004;3789.5073640426567;3791.9052023698523;5794.13088036781;5837.270341207349;5849.034909239927;5855.473007429352;5860.941390586039;5608.635438696471;5615.129654903497;5626.634268772516;5632.9436705632415;5633.464820842013;5444.101723215784;5610.298712660918;5646.153077038477;5652.915206271991;5665.178549110274;5537.944620553743;5539;5547.972260138674;5548.528375088163;5553.4724201200825;5698.515626171656;5702.885942281214;5703.686297253691;5705.343885453226;5707.315122185364;5419.536725084126;5555.2778138843305;5556.972215138899;5559.305086864142;5568.136938774496 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: |5;yui.html;644.6357807838571;664.9268580456151;693.6878404717878;729.7044696897758;755.9190357788362;11507.482163302651;11751.412429378539;11786.233894796833;11824.231424957372;11826.526938922454;11344.262622929504;12144.635660930164;12261.693457663541;12268.693282667939;12294.262344259329;621.4748537485817;629.5655997361829;779.863523883321;784.9293563579276;796.41861441148;799.3924617290843;801.5591424716412;803.8673618852882;807.1363640904235;807.2895851650569;834.1241696218976;841.6212704283066;841.8737189421574;842.048485211713;842.2377748137945;648.5006544960402;656.1142457682139;825.2078005115096;839.4249938791886;842.1031601344548;621.6922623301449;621.7450845153511;621.7948077134535;621.8196722950339;621.9284782250054;11785.528578856836;11941.462634181396;11972.281663100155;11974.521019159223;11981.580644677395;11051.226414151013;11589.884101158965;11706.12204084697;11785.175037747362;12015;9490.620375184984;9695.854562181574;9762.707118786448;9766.560504777302;9824.361416507976;3248.4477638801222;3253.7722359434847;3267.57521522203;3300.042987533612;3366.023853082603;36618.81690591557;36799.264014719556;36891.4466283006;37051.62948370509;37184;8864.73405797827;9061.59222834974;9069.54652267384;9214.539273036322;9424.811503769886;15813;15823.367065317489;15846.76229856553;15869.285882135331;15886.443974460839;6190.473809726133;6253.280872699606;6324.2410910691015;6362.236531616236;6553.901691474632;3472.5138480612736;3490.406630872758;3566.037169964095;3566.0906468850794;3580.4092324766643;2604.0104760191007;2620.3842097107163;2624.4882247961846;2638.630591717161;2639.934001649974;479.0706030301204;485.1921550618252;498.76558017731605;502.7335512178551;504.3216873305398;546.1998172677047;549.0994768579533;562.3476766950399;565.9858503537445;577.5495113811234;7520.247975202546;7524.209957954336;7584.62076896153;8022.077461092049;8062.355011599058;457.8397560853741;550.2544052808466;571.1033677126954;609.765240382456;617.219217689623;3207.3264614430764;3445.5693038370205;3533.8939831805087;3560.359135355609;3913;46690.29964550534;47290.76354618205;47460.52539474561;47619.76190119096;54809.72595137078;42049.369259461135;42196.57803421988;42235.57764422378;42525.57474425216;42951.14097718028;38163;38303.233935321136;38614;38739.225215495535;39048.21903561913;7476.4392670551015;8006.83986320282;8108.918910810817;8150.673973041012;8221.588920554068;29815.85092074526;30363.696363036088;30710;30730.385392292475;30869.69130308668;34869;35264;38169.80915095518;38312.616873830906;38892.80553597214;9505;9520.285978551776;9687.806243875224;9753.853692194481;9944;10771.6229931952;10852.837207442053;11066.280691755332;11440;11742.236754610924;9927.453990030328;9957.850632240667;10018.699439016842;10184.949075254577;10311.793764124826;10073.244506661884;10073.445960472245;10090.596376144871;10186.185105191715;10276.22928280367;10152.289339746147;10222.080012798884;10250.743731406774;10253.692389228336;10295.94852025735;8908.5991130398;8956.193942545202;9251.96165638829;9313.301502387483;9828.950855245677;8506.043609969865;8935.419197752126;9074.682386116454;9148.954255228682;9171.174594286545 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,812 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664390011__endTimestamp 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4626.97 Median:4734.79 stddev:476.39 (10.1%) stddev-sans-first:450.83 04:33:10 INFO - 2015-12-09 04:33:10,025 DEBUG : BROWSER_OUTPUT: Values: 2610.5 2683.6 2691.2 2693.9 2706.7 4474.1 4599.7 4661.7 4708.1 4708.7 4593.9 4597.7 4678.2 4686.6 4715.2 4292.0 4320.3 4337.0 4422.7 4452.0 4367.4 4410.6 4432.2 4436.7 4476.0 4170.1 4242.2 4265.6 4288.3 4347.2 4323.0 4345.8 4355.1 4359.5 4380.3 4332.7 4337.7 4339.3 4355.9 4359.1 4407.3 4495.5 4514.5 4554.8 4691.0 5016.9 5026.0 5027.0 5031.6 5077.2 5044.5 5048.7 5052.8 5054.4 5055.9 4571.7 4614.7 4689.1 4698.3 4713.7 5099.1 5122.1 5126.7 5127.3 5184.0 4949.5 4949.9 4952.4 4957.4 5003.7 4816.8 4868.8 4908.7 4915.4 4927.0 4965.2 5032.4 5032.6 5039.3 5040.2 5004.2 5005.9 5017.9 5027.1 5044.6 4089.2 4157.7 4194.2 4223.5 4244.7 3635.4 3663.2 3694.9 3710.1 3731.7 4252.6 4322.3 4323.8 4356.7 4370.5 4812.2 4916.7 4920.7 5022.9 5028.7 4263.9 4329.3 4331.2 4350.9 4372.6 4450.1 4481.6 4487.1 4491.1 4542.2 4573.5 4696.1 4701.5 4758.1 4760.1 4910.3 4916.4 4934.6 5031.2 5048.8 4725.5 4727.1 4734.8 4747.9 4791.9 4960.0 4960.1 4965.6 4974.5 5004.6 4839.0 4893.7 4950.4 4970.8 5019.9 4921.2 4935.9 4936.5 4944.7 4951.0 4924.0 4935.6 4940.0 4950.9 4970.4 4669.5 4732.2 4802.5 4813.0 4872.4 4891.6 4916.9 4920.7 4921.3 4941.7 4811.0 4816.8 4817.3 4820.0 4862.8 04:33:10 INFO - 2015-12-09 04:33:10,026 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,026 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44655.09 Median:317226.50 stddev:78983.29 (24.9%) stddev-sans-first:79135.39 04:33:10 INFO - 2015-12-09 04:33:10,026 DEBUG : BROWSER_OUTPUT: Values: 537.0 540.9 545.3 549.1 556.3 26659.6 27025.6 27100.3 34963.1 35618.0 40725.8 41255.4 41327.0 41341.6 41359.8 7854.1 8022.7 8029.6 8032.1 8040.3 7189.5 7373.6 9900.3 10153.9 10195.9 9961.4 10027.7 10113.8 10140.3 10148.5 7164.9 7352.5 9930.4 10033.4 10035.9 9985.9 10310.7 10316.2 10349.3 10359.7 36756.0 37627.8 37716.4 37730.0 37800.6 2751.6 2872.4 2895.9 2917.9 3019.4 26778.0 26832.7 27200.0 28937.0 30354.0 3433.6 3474.8 3522.1 3525.5 3527.1 326838.0 329832.0 330164.0 330283.0 330500.0 51396.7 55109.7 55895.7 56001.4 56005.4 45313.0 64041.4 66659.0 66746.3 66802.0 13067.0 13204.8 13241.5 13248.3 13271.1 9573.2 9609.2 9656.8 9665.2 9682.5 19242.1 19471.6 19499.7 19520.9 19541.5 7395.7 7613.8 7631.2 7728.4 7840.9 819.6 869.9 897.3 916.8 919.3 26231.5 26247.9 26823.3 27044.3 27085.6 846.3 850.2 948.5 972.2 987.0 11894.6 12063.0 12099.6 12106.1 12154.3 311383.0 315367.0 316023.0 316781.0 317672.0 47400.8 47940.0 48024.5 48046.5 48065.0 1186.7 1237.0 1237.6 1241.1 1259.1 21446.4 21736.4 22331.4 22408.6 22543.7 34697.5 35197.1 35365.1 35376.3 36178.5 250466.0 250670.0 250778.0 250991.0 251886.0 24519.9 25101.6 28884.3 29476.0 29627.7 33117.3 33118.5 33177.7 33408.7 33967.8 30419.8 30478.4 30835.4 30980.7 31168.4 24451.5 30642.8 30935.8 31234.2 32124.5 31433.0 31513.2 31659.8 31921.2 38187.2 27491.3 28591.7 30128.4 30130.4 30325.8 23573.6 23664.3 23823.3 23991.8 24002.4 04:33:10 INFO - 2015-12-09 04:33:10,026 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,026 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25795.37 Median:4118.39 stddev:77638.32 (1885.2%) stddev-sans-first:77832.44 04:33:10 INFO - 2015-12-09 04:33:10,027 DEBUG : BROWSER_OUTPUT: Values: 261.3 264.6 269.6 276.1 284.8 10367.9 15617.2 16288.3 16293.3 16339.2 14668.5 14949.1 15059.9 15486.3 15501.1 5572.6 5729.8 5763.9 5774.1 5775.9 5681.9 5720.1 5722.6 5726.8 5735.3 4088.8 4124.8 5584.6 5746.5 6424.2 6579.6 6589.6 6596.7 6624.9 6626.1 6185.1 6371.8 6380.9 6387.3 6391.1 20125.0 20197.7 20470.4 20689.4 20696.0 1704.4 1731.5 1767.6 1841.3 1987.4 8500.3 8684.0 8690.7 8818.7 8863.1 1674.8 1679.0 1691.7 1732.8 1764.4 51391.5 54557.5 54854.5 54865.5 54958.0 9659.8 9692.9 9717.9 9731.7 9770.0 12045.3 12070.8 12070.9 12086.5 12100.1 6836.8 6907.7 6958.6 7012.2 7035.1 6674.5 6739.7 6760.3 6768.2 6786.3 4032.8 4034.0 4043.6 4112.0 4145.6 1561.7 1614.2 1616.1 1640.5 1710.8 321.1 342.5 346.9 801.6 827.1 8739.2 9033.4 9035.8 15415.7 15746.1 710.8 801.3 826.8 827.4 851.5 8301.5 8431.5 8624.7 9203.8 9551.5 465512.0 466200.0 477002.0 483075.0 483679.0 69549.7 73489.3 73594.0 73952.3 74099.0 1023.0 1073.3 1077.5 1081.7 1089.9 13879.2 13889.7 14496.6 14688.3 14734.3 32711.0 32889.3 32894.2 33226.8 33818.3 40622.4 41074.6 41106.8 42242.0 42530.0 7991.1 8324.3 8331.0 8360.7 8361.9 9670.3 9710.3 10289.8 15375.9 15481.0 12979.5 13252.3 13364.7 13391.7 13479.3 11860.9 12220.5 12260.6 12524.7 12902.8 13379.7 13527.5 13553.8 13748.0 13994.4 8038.2 8047.4 8059.2 8289.8 8465.7 11589.2 13187.2 13203.3 13351.5 13851.9 04:33:10 INFO - 2015-12-09 04:33:10,027 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,027 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4835.08 Median:5910.31 stddev:2474.65 (41.9%) stddev-sans-first:2468.23 04:33:10 INFO - 2015-12-09 04:33:10,027 DEBUG : BROWSER_OUTPUT: Values: 1414.5 1537.5 1539.3 1566.0 1633.5 5932.4 6771.8 6973.7 6978.7 6987.2 6687.9 6872.3 6872.8 6891.2 6895.0 1966.8 1978.0 1987.6 1989.3 1990.5 2001.1 2007.1 2023.8 2095.4 2098.8 2011.7 2032.6 2058.4 2058.7 2060.6 2034.8 2052.6 2056.1 2065.0 2068.3 2035.6 2059.7 2076.9 2077.9 2078.5 6836.2 6898.4 6899.8 6909.4 6915.2 3897.2 3954.6 3954.7 3957.0 3968.9 2663.5 2675.2 2717.8 2731.1 2734.4 786.4 804.1 851.6 852.7 1751.4 9031.3 9172.3 9190.3 9221.4 9231.9 3523.8 3540.9 3545.8 3605.9 3781.3 8241.5 8247.5 8257.1 8268.0 8326.9 4198.2 4198.5 4207.6 4220.9 4225.8 3136.1 3170.7 3595.3 3805.7 3810.2 3331.4 3397.8 3400.4 3420.3 3426.7 1056.8 1081.0 1085.2 1092.2 1095.5 1040.8 1062.4 1139.8 1161.3 1163.9 6531.7 6559.1 6568.4 6591.0 6609.7 1076.6 1108.1 1123.2 1135.3 1143.5 4985.8 5013.3 5039.9 5055.5 5056.1 7916.8 8030.7 8278.2 8278.8 8293.3 8182.3 8198.0 8243.3 8251.5 8254.7 6548.9 6684.4 6734.4 6794.8 6825.2 6314.8 6337.3 6345.7 6354.2 6372.4 7507.1 7583.0 7600.2 7652.4 7668.7 7701.1 7747.8 7807.0 7846.6 7847.8 4978.2 5045.4 5827.4 5909.7 5910.9 6393.8 6494.9 6503.5 6534.9 6549.0 6009.2 6071.0 6080.6 6177.2 6323.3 5991.6 6027.4 6074.6 6099.3 6114.6 6163.7 6348.3 6379.6 6385.0 6388.9 5616.1 5862.1 5862.8 5865.1 5866.1 5860.4 5929.1 5934.2 5962.0 5986.1 04:33:10 INFO - 2015-12-09 04:33:10,028 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,028 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4580.10 Median:5301.82 stddev:1412.84 (26.6%) stddev-sans-first:1378.95 04:33:10 INFO - 2015-12-09 04:33:10,028 DEBUG : BROWSER_OUTPUT: Values: 252.0 255.2 258.2 259.0 259.2 5290.5 5313.1 5319.4 5344.5 5377.8 4706.5 5035.2 5051.8 5084.4 5263.4 3943.9 3982.1 3983.7 3996.2 3997.2 3980.3 3985.7 3986.6 3988.9 3990.5 3767.3 3832.4 3873.8 3911.8 3949.9 3943.3 3943.9 3948.5 3954.6 3955.1 3387.2 3391.8 3395.1 3401.5 3405.9 5125.6 5127.4 5129.3 5130.9 5143.8 4458.6 4539.3 4552.8 4553.6 4556.4 5553.8 5556.0 5558.7 5561.8 5567.5 3716.7 3719.7 3721.1 3723.4 3731.2 5855.6 5860.9 5865.4 5866.1 5866.2 3620.8 3810.6 3811.1 3815.7 3817.8 3830.8 3835.2 3836.0 3837.3 3838.0 4511.4 4513.8 4515.0 4518.5 4519.6 5589.4 5598.1 5599.2 5600.5 5603.0 1316.0 1325.6 1327.2 1327.8 1328.1 865.4 871.1 878.5 891.7 892.9 4912.9 4914.1 4918.0 4919.8 4920.1 5820.9 5827.9 5832.3 5832.3 5833.6 4728.0 4912.3 4915.7 4916.4 4916.5 3032.7 3059.4 3143.1 3144.8 3153.7 5475.0 5488.8 5492.9 5495.3 5497.9 6002.2 6004.7 6008.4 6013.9 6016.4 5378.2 5450.0 5481.9 5492.1 5494.3 5829.3 5853.9 5861.1 5864.4 5864.9 5716.7 5721.6 5728.3 5734.0 5736.2 5329.1 5482.1 5483.2 5485.1 5485.7 3753.8 3783.2 3785.1 3789.5 3791.9 5794.1 5837.3 5849.0 5855.5 5860.9 5608.6 5615.1 5626.6 5632.9 5633.5 5444.1 5610.3 5646.2 5652.9 5665.2 5537.9 5539.0 5548.0 5548.5 5553.5 5698.5 5702.9 5703.7 5705.3 5707.3 5419.5 5555.3 5557.0 5559.3 5568.1 04:33:10 INFO - 2015-12-09 04:33:10,028 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,028 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11859.45 Median:47375.64 stddev:13135.67 (27.7%) stddev-sans-first:13145.52 04:33:10 INFO - 2015-12-09 04:33:10,030 DEBUG : BROWSER_OUTPUT: Values: 644.6 664.9 693.7 729.7 755.9 11507.5 11751.4 11786.2 11824.2 11826.5 11344.3 12144.6 12261.7 12268.7 12294.3 621.5 629.6 779.9 784.9 796.4 799.4 801.6 803.9 807.1 807.3 834.1 841.6 841.9 842.0 842.2 648.5 656.1 825.2 839.4 842.1 621.7 621.7 621.8 621.8 621.9 11785.5 11941.5 11972.3 11974.5 11981.6 11051.2 11589.9 11706.1 11785.2 12015.0 9490.6 9695.9 9762.7 9766.6 9824.4 3248.4 3253.8 3267.6 3300.0 3366.0 36618.8 36799.3 36891.4 37051.6 37184.0 8864.7 9061.6 9069.5 9214.5 9424.8 15813.0 15823.4 15846.8 15869.3 15886.4 6190.5 6253.3 6324.2 6362.2 6553.9 3472.5 3490.4 3566.0 3566.1 3580.4 2604.0 2620.4 2624.5 2638.6 2639.9 479.1 485.2 498.8 502.7 504.3 546.2 549.1 562.3 566.0 577.5 7520.2 7524.2 7584.6 8022.1 8062.4 457.8 550.3 571.1 609.8 617.2 3207.3 3445.6 3533.9 3560.4 3913.0 46690.3 47290.8 47460.5 47619.8 54809.7 42049.4 42196.6 42235.6 42525.6 42951.1 38163.0 38303.2 38614.0 38739.2 39048.2 7476.4 8006.8 8108.9 8150.7 8221.6 29815.9 30363.7 30710.0 30730.4 30869.7 34869.0 35264.0 38169.8 38312.6 38892.8 9505.0 9520.3 9687.8 9753.9 9944.0 10771.6 10852.8 11066.3 11440.0 11742.2 9927.5 9957.9 10018.7 10184.9 10311.8 10073.2 10073.4 10090.6 10186.2 10276.2 10152.3 10222.1 10250.7 10253.7 10295.9 8908.6 8956.2 9252.0 9313.3 9829.0 8506.0 8935.4 9074.7 9149.0 9171.2 04:33:10 INFO - 2015-12-09 04:33:10,030 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:33:10 INFO - 2015-12-09 04:33:10,030 DEBUG : BROWSER_OUTPUT: 04:33:10 INFO - 2015-12-09 04:33:10,844 INFO : Browser exited with error code: 0 04:33:10 INFO - 2015-12-09 04:33:10,860 INFO : Completed test dromaeo_css (00:18:36) 04:33:10 INFO - 2015-12-09 04:33:10,860 INFO : Starting test kraken 04:33:10 INFO - 2015-12-09 04:33:10,860 DEBUG : operating with platform_type : linux_ 04:33:10 INFO - 2015-12-09 04:33:10,860 INFO : Initialising browser for kraken test... 04:33:10 INFO - 2015-12-09 04:33:10,866 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JYR0t/profile http://localhost:51117/getInfo.html 04:33:15 INFO - 2015-12-09 04:33:15,133 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:33:15 INFO - 2015-12-09 04:33:15,133 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:33:15 INFO - 2015-12-09 04:33:15,133 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:33:15 INFO - 2015-12-09 04:33:15,133 DEBUG : BROWSER_OUTPUT: __metrics 04:33:15 INFO - 2015-12-09 04:33:15,229 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:33:15 INFO - 2015-12-09 04:33:15,290 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:15 ERROR - 2015-12-09 04:33:15,306 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 04:33:16 INFO - 2015-12-09 04:33:16,135 INFO : Browser initialized. 04:33:16 INFO - 2015-12-09 04:33:16,136 INFO : Running cycle 1/1 for kraken test... 04:33:16 INFO - 2015-12-09 04:33:16,136 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1JYR0t/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:33:28 INFO - 2015-12-09 04:33:28,127 DEBUG : BROWSER_OUTPUT: RSS: Main: 143163392 04:33:28 INFO - 2015-12-09 04:33:28,127 DEBUG : BROWSER_OUTPUT: 04:33:30 INFO - 2015-12-09 04:33:30,721 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-beat-detection) 04:33:31 INFO - 2015-12-09 04:33:31,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 178634752 04:33:31 INFO - 2015-12-09 04:33:31,303 DEBUG : BROWSER_OUTPUT: 04:33:34 INFO - 2015-12-09 04:33:34,019 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-dft) 04:33:34 INFO - 2015-12-09 04:33:34,592 DEBUG : BROWSER_OUTPUT: RSS: Main: 166395904 04:33:34 INFO - 2015-12-09 04:33:34,593 DEBUG : BROWSER_OUTPUT: 04:33:37 INFO - 2015-12-09 04:33:37,594 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-fft) 04:33:38 INFO - 2015-12-09 04:33:38,160 DEBUG : BROWSER_OUTPUT: RSS: Main: 154480640 04:33:38 INFO - 2015-12-09 04:33:38,160 DEBUG : BROWSER_OUTPUT: 04:33:40 INFO - 2015-12-09 04:33:40,192 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51117/tests/kraken/driver.html?testName=audio-oscillator) 04:33:40 INFO - 2015-12-09 04:33:40,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 155967488 04:33:40 INFO - 2015-12-09 04:33:40,758 DEBUG : BROWSER_OUTPUT: 04:33:42 INFO - 2015-12-09 04:33:42,971 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:33:43 INFO - 2015-12-09 04:33:43,531 DEBUG : BROWSER_OUTPUT: RSS: Main: 157716480 04:33:43 INFO - 2015-12-09 04:33:43,531 DEBUG : BROWSER_OUTPUT: 04:33:46 INFO - 2015-12-09 04:33:46,510 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-darkroom) 04:33:47 INFO - 2015-12-09 04:33:47,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 157532160 04:33:47 INFO - 2015-12-09 04:33:47,083 DEBUG : BROWSER_OUTPUT: 04:33:50 INFO - 2015-12-09 04:33:50,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51117/tests/kraken/driver.html?testName=imaging-desaturate) 04:33:51 INFO - 2015-12-09 04:33:51,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 157827072 04:33:51 INFO - 2015-12-09 04:33:51,139 DEBUG : BROWSER_OUTPUT: 04:33:53 INFO - 2015-12-09 04:33:53,989 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51117/tests/kraken/driver.html?testName=json-parse-financial) 04:33:54 INFO - 2015-12-09 04:33:54,575 DEBUG : BROWSER_OUTPUT: RSS: Main: 158253056 04:33:54 INFO - 2015-12-09 04:33:54,576 DEBUG : BROWSER_OUTPUT: 04:33:56 INFO - 2015-12-09 04:33:56,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51117/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:33:56 INFO - 2015-12-09 04:33:56,906 DEBUG : BROWSER_OUTPUT: RSS: Main: 171642880 04:33:56 INFO - 2015-12-09 04:33:56,906 DEBUG : BROWSER_OUTPUT: 04:33:58 INFO - 2015-12-09 04:33:58,815 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:33:59 INFO - 2015-12-09 04:33:59,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 169185280 04:33:59 INFO - 2015-12-09 04:33:59,416 DEBUG : BROWSER_OUTPUT: 04:34:01 INFO - 2015-12-09 04:34:01,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:34:02 INFO - 2015-12-09 04:34:02,150 DEBUG : BROWSER_OUTPUT: RSS: Main: 181125120 04:34:02 INFO - 2015-12-09 04:34:02,150 DEBUG : BROWSER_OUTPUT: 04:34:04 INFO - 2015-12-09 04:34:04,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:34:05 INFO - 2015-12-09 04:34:05,312 DEBUG : BROWSER_OUTPUT: RSS: Main: 186982400 04:34:05 INFO - 2015-12-09 04:34:05,313 DEBUG : BROWSER_OUTPUT: 04:34:07 INFO - 2015-12-09 04:34:07,926 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:34:08 INFO - 2015-12-09 04:34:08,507 DEBUG : BROWSER_OUTPUT: RSS: Main: 183836672 04:34:08 INFO - 2015-12-09 04:34:08,507 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51117/tests/kraken/driver.html?testName=ai-astar) 04:34:10 INFO - 2015-12-09 04:34:10,500 DEBUG : BROWSER_OUTPUT: RSS: Main: 243048448 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;112;106;111;112;111;102;112;112;103 04:34:10 INFO - 2015-12-09 04:34:10,501 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;134;152;167;129;152;148;135;178;129 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;160;161;163;161;161;161;161;162 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;88;93;72;72;72;93;88;73 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;95;128;94;95;94;125;94;95;130 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;109;109;110;109;109;110;109 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;147;146;146;147;146;147 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;96;95;95;95;95 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;73;73;72;73;72;74;72;73;71 04:34:10 INFO - 2015-12-09 04:34:10,502 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;68;68;68;69;69;69;68;69 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;91;85;86;86;85;85;89;86;86 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;127;126;126;117;125;128;126;123;127 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;142;150;153;158;146;148;141;145;136 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;70;69;68;68;67;68;68;69 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,993 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664450496__endTimestamp 04:34:10 INFO - 2015-12-09 04:34:10,503 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.00 Median:111.50 stddev:3.92 (3.5%) stddev-sans-first:4.15 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: Values: 109.0 112.0 106.0 111.0 112.0 111.0 102.0 112.0 112.0 103.0 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.80 Median:152.00 stddev:16.38 (10.8%) stddev-sans-first:17.22 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: Values: 154.0 134.0 152.0 167.0 129.0 152.0 148.0 135.0 178.0 129.0 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:0.94 (0.6%) stddev-sans-first:0.93 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 160.0 161.0 163.0 161.0 161.0 161.0 161.0 162.0 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:80.50 stddev:9.71 (12.1%) stddev-sans-first:9.92 04:34:10 INFO - 2015-12-09 04:34:10,505 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 88.0 93.0 72.0 72.0 72.0 93.0 88.0 73.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:104.40 Median:94.00 stddev:16.11 (17.1%) stddev-sans-first:16.64 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: Values: 94.0 95.0 128.0 94.0 95.0 94.0 125.0 94.0 95.0 130.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.30 Median:109.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 110.0 109.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.60 Median:147.00 stddev:0.52 (0.4%) stddev-sans-first:0.50 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 147.0 146.0 146.0 147.0 146.0 147.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:72.60 Median:73.00 stddev:0.84 (1.2%) stddev-sans-first:0.88 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 73.0 72.0 73.0 72.0 74.0 72.0 73.0 71.0 04:34:10 INFO - 2015-12-09 04:34:10,506 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.53 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 69.0 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:2.25 (2.6%) stddev-sans-first:2.07 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: Values: 83.0 91.0 85.0 86.0 86.0 85.0 85.0 89.0 86.0 86.0 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.40 Median:126.50 stddev:3.37 (2.7%) stddev-sans-first:3.32 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: Values: 129.0 127.0 126.0 126.0 117.0 125.0 128.0 126.0 123.0 127.0 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.70 Median:147.00 stddev:6.82 (4.6%) stddev-sans-first:6.64 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: Values: 138.0 142.0 150.0 153.0 158.0 146.0 148.0 141.0 145.0 136.0 04:34:10 INFO - 2015-12-09 04:34:10,507 DEBUG : BROWSER_OUTPUT: 04:34:10 INFO - 2015-12-09 04:34:10,508 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.60 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 04:34:10 INFO - 2015-12-09 04:34:10,508 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 69.0 68.0 68.0 67.0 68.0 68.0 69.0 04:34:10 INFO - 2015-12-09 04:34:10,508 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:10 INFO - 2015-12-09 04:34:10,508 DEBUG : BROWSER_OUTPUT: 04:34:11 INFO - 2015-12-09 04:34:11,364 INFO : Browser exited with error code: 0 04:34:11 INFO - 2015-12-09 04:34:11,417 INFO : Completed test kraken (00:01:00) 04:34:11 INFO - 2015-12-09 04:34:11,417 INFO : Starting test v8_7 04:34:11 INFO - 2015-12-09 04:34:11,417 DEBUG : operating with platform_type : linux_ 04:34:11 INFO - 2015-12-09 04:34:11,417 INFO : Initialising browser for v8_7 test... 04:34:11 INFO - 2015-12-09 04:34:11,423 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV842W_/profile http://localhost:51117/getInfo.html 04:34:15 INFO - 2015-12-09 04:34:15,423 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:34:15 INFO - 2015-12-09 04:34:15,423 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:34:15 INFO - 2015-12-09 04:34:15,424 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:34:15 INFO - 2015-12-09 04:34:15,424 DEBUG : BROWSER_OUTPUT: __metrics 04:34:15 INFO - 2015-12-09 04:34:15,593 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:34:15 INFO - 2015-12-09 04:34:15,657 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:16 INFO - 2015-12-09 04:34:16,792 INFO : Browser initialized. 04:34:16 INFO - 2015-12-09 04:34:16,793 INFO : Running cycle 1/1 for v8_7 test... 04:34:16 INFO - 2015-12-09 04:34:16,793 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpV842W_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:34:28 INFO - 2015-12-09 04:34:28,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 142536704 04:34:28 INFO - 2015-12-09 04:34:28,753 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51117/tests/v8_7/run.html (next: http://localhost:51117/tests/v8_7/run.html) 04:34:50 INFO - 2015-12-09 04:34:50,475 DEBUG : BROWSER_OUTPUT: RSS: Main: 449052672 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:34:50 INFO - 2015-12-09 04:34:50,476 DEBUG : BROWSER_OUTPUT: |0;Richards;172.4435247456458 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.77624206200971 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.6291446085261 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2006.0120240480962 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |7;RegExp;26921.052631578947 04:34:50 INFO - 2015-12-09 04:34:50,477 DEBUG : BROWSER_OUTPUT: |8;Splay;597.9869745411486 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: __startTimestamp1449664490475__endTimestamp 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:34:50 INFO - 2015-12-09 04:34:50,478 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:172.44 Median:172.44 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: Values: 172.4 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.78 Median:186.78 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: Values: 186.8 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.63 Median:278.63 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,479 DEBUG : BROWSER_OUTPUT: Values: 278.6 04:34:50 INFO - 2015-12-09 04:34:50,480 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,480 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,481 DEBUG : BROWSER_OUTPUT: Values: 5133.3 04:34:50 INFO - 2015-12-09 04:34:50,481 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,481 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2006.01 Median:2006.01 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,481 DEBUG : BROWSER_OUTPUT: Values: 2006.0 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: Values: 791.8 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: Values: 12370.4 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,482 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26921.05 Median:26921.05 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: Values: 26921.1 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.99 Median:597.99 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: Values: 598.0 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 04:34:50 INFO - 2015-12-09 04:34:50,483 DEBUG : BROWSER_OUTPUT: Values: 4822.1 04:34:50 INFO - 2015-12-09 04:34:50,484 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:34:50 INFO - 2015-12-09 04:34:50,484 DEBUG : BROWSER_OUTPUT: 04:34:51 INFO - 2015-12-09 04:34:51,376 INFO : Browser exited with error code: 0 04:34:51 INFO - 2015-12-09 04:34:51,390 INFO : Completed test v8_7 (00:00:39) 04:34:51 INFO - 2015-12-09 04:34:51,429 INFO : Completed test suite (00:20:17) 04:34:51 INFO - 2015-12-09 04:34:51,429 DEBUG : Working with test: dromaeo_css 04:34:51 INFO - 2015-12-09 04:34:51,429 DEBUG : Generating results file: dromaeo_css 04:34:51 INFO - 2015-12-09 04:34:51,430 DEBUG : Working with test: kraken 04:34:51 INFO - 2015-12-09 04:34:51,430 DEBUG : Generating results file: kraken 04:34:51 INFO - 2015-12-09 04:34:51,430 INFO : javascript benchmark 04:34:51 INFO - 2015-12-09 04:34:51,431 DEBUG : Working with test: v8_7 04:34:51 INFO - 2015-12-09 04:34:51,431 DEBUG : Generating results file: v8_7 04:34:51 INFO - 2015-12-09 04:34:51,431 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-12-09 04:34:51,488 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 04:34:51 INFO - 2015-12-09 04:34:51,488 DEBUG : process_Request line: dromaeo_css 6221.25 graph.html#tests=[[72,94,35]] 04:34:51 INFO - 2015-12-09 04:34:51,488 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-12-09 04:34:51,518 DEBUG : process_Request line: kraken 1519.50 graph.html#tests=[[232,94,35]] 04:34:51 INFO - 2015-12-09 04:34:51,519 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:34:51 INFO - 2015-12-09 04:34:51,553 DEBUG : process_Request line: v8_7 19713.35 graph.html#tests=[[230,94,35]] 04:34:51 INFO - 2015-12-09 04:34:51,554 INFO : javascript benchmark 04:34:51 INFO - 2015-12-09 04:34:51,558 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2610.5301045811757, 2683.6242925990377, 2691.219546331563, 2693.9057133000347, 2706.742859428354, 4474.08281302333, 4599.724016559009, 4661.720296782191, 4708.058388322336, 4708.693934894234, 4593.931091033629, 4597.701149425285, 4678.157931572324, 4686.601638860701, 4715.245560710278, 4292.0, 4320.265554855667, 4337.04584991303, 4422.668299877506, 4452.0, 4367.388565600819, 4410.603045725884, 4432.246518091933, 4436.66724995625, 4475.977620111895, 4170.124273902484, 4242.236397448458, 4265.616094551474, 4288.335308027261, 4347.239233134221, 4323.048929235563, 4345.760983145926, 4355.063661312801, 4359.542248063939, 4380.3210502372185, 4332.653387729006, 4337.696361254713, 4339.305711086211, 4355.912881742379, 4359.149965756678, 4407.316865885793, 4495.46054473462, 4514.548545145492, 4554.772261386917, 4690.95309046912, 5016.874578135539, 5026.0, 5027.044861476308, 5031.647784655075, 5077.162268225738, 5044.470330615306, 5048.72232027242, 5052.8484145475695, 5054.368203974504, 5055.9241611375855, 4571.725696458223, 4614.676972611952, 4689.062187562467, 4698.271767875985, 4713.717176969393, 5099.056674515226, 5122.103631864409, 5126.6923984561045, 5127.307813445137, 5184.040952423814, 4949.529794669501, 4949.876253093701, 4952.4304704959395, 4957.429895562056, 5003.674761140514, 4816.783244753994, 4868.756562171877, 4908.705477671351, 4915.3855768029, 4927.039227350704, 4965.180745177077, 5032.446430892599, 5032.572231360302, 5039.3448851649055, 5040.243963405445, 5004.199328107486, 5005.924911126336, 5017.9462312913965, 5027.120253955543, 5044.621653376012, 4089.2230476209425, 4157.688173387008, 4194.203101410722, 4223.535411104776, 4244.702870799076, 3635.381985062546, 3663.19409729859, 3694.8891533254045, 3710.128119891823, 3731.7201209909367, 4252.553481884358, 4322.286822674287, 4323.762193079411, 4356.716813407118, 4370.475542934868, 4812.181929072066, 4916.70499770015, 4920.704757714549, 5022.949770502249, 5028.748562571856, 4263.850765223202, 4329.307310830252, 4331.177076355482, 4350.891227719332, 4372.584604462571, 4450.06548624786, 4481.574250446202, 4487.125010622963, 4491.079328737601, 4542.227821270392, 4573.496915339377, 4696.131215725101, 4701.5298470154075, 4758.1435341638835, 4760.143174228534, 4910.263460480956, 4916.434610019894, 4934.580560652241, 5031.245313202902, 5048.772805223847, 4725.503822098768, 4727.149113159664, 4734.786934588021, 4747.905041899212, 4791.856244312677, 4960.007998400407, 4960.057589058068, 4965.577925876197, 4974.527419895104, 5004.599632029356, 4838.951610483991, 4893.730844803427, 4950.430700469492, 4970.801167953241, 5019.899602007867, 4921.212605983025, 4935.851924442272, 4936.481669424658, 4944.703317800943, 4950.975245123751, 4924.0, 4935.580475659609, 4940.0, 4950.900981980412, 4970.353853999101, 4669.48635650085, 4732.195526760528, 4802.51974802517, 4813.03739252158, 4872.4153101628035, 4891.63312751538, 4916.901661966669, 4920.6801557898625, 4921.2864134700985, 4941.65408421407, 4811.0, 4816.759162041954, 4817.253325734517, 4820.0, 4862.82980095695], "unit": "ms", "name": "dojo.html", "value": 4597.4594428338505}, {"lowerIsBetter": false, "replicates": [537.001177809275, 540.8566729816599, 545.3428618514689, 549.066586802436, 556.3185098254638, 26659.6001059984, 27025.59461608075, 27100.322491937688, 34963.12592185197, 35618.0, 40725.79637101811, 41255.38116928248, 41327.0, 41341.58658413415, 41359.79320103395, 7854.057513098436, 8022.679092836309, 8029.598520074002, 8032.116467188634, 8040.316573091294, 7189.460790440712, 7373.5575865448245, 9900.306978511508, 10153.898461015406, 10195.949020254888, 9961.402315861036, 10027.749306267366, 10113.797724045515, 10140.290179687425, 10148.49257537124, 7164.892526612105, 7352.485326027127, 9930.361490354118, 10033.397996120257, 10035.899641003643, 9985.850212246822, 10310.7422314442, 10316.226283028804, 10349.275550711453, 10359.689209323733, 36756.0, 37627.81186094052, 37716.43425348622, 37730.0, 37800.62199378026, 2751.614773931651, 2872.353720412911, 2895.9276018099504, 2917.897873574436, 3019.350839569481, 26778.0, 26832.731672683218, 27200.047998320162, 28937.0, 30354.0, 3433.6051354094348, 3474.826258687081, 3522.084258092889, 3525.541679581638, 3527.0829584308262, 326838.0, 329831.9999999976, 330164.0, 330283.0, 330500.0, 51396.74301628543, 55109.724451378286, 55895.72052139713, 56001.43998560044, 56005.439945600025, 45313.0, 64041.35958640354, 66659.0, 66746.33253667498, 66802.0, 13067.0, 13204.801927971088, 13241.470341186245, 13248.337583120805, 13271.137376070525, 9573.234141268682, 9609.183219426288, 9656.75858103539, 9665.226781857435, 9682.515874206261, 19242.134103965076, 19471.610567788564, 19499.707504387447, 19520.90239548793, 19541.51146221356, 7395.741149059864, 7613.847723045508, 7631.1605723370385, 7728.381729461629, 7840.882386764203, 819.5943008210974, 869.8695195720693, 897.3490113825891, 916.7616419730919, 919.3426699909596, 26231.475370492484, 26247.868760656074, 26823.329416764736, 27044.32389190286, 27085.593716094274, 846.3139369911428, 850.1974027263948, 948.4641177734558, 972.1736523954582, 987.0474991633108, 11894.583689570823, 12063.0, 12099.57651482194, 12106.092043096804, 12154.33151176676, 311383.0, 315367.0, 316023.0, 316781.0, 317672.0, 47400.7629961848, 47940.0, 48024.51975480201, 48046.5195348049, 48065.0, 1186.6736647422028, 1236.9628911132681, 1237.6472705279132, 1241.1436109084702, 1259.0619988108735, 21446.356609301747, 21736.36977226746, 22331.44171395728, 22408.551828963657, 22543.66184507201, 34697.479537806445, 35197.120071998404, 35365.1158721034, 35376.29247414986, 36178.4573231407, 250466.0, 250670.0, 250778.0, 250991.0, 251886.0, 24519.877400612884, 25101.623475647513, 28884.27789305284, 29476.0, 29627.703722962495, 33117.33765324728, 33118.5032224512, 33177.668223318426, 33408.665913340556, 33967.830160850026, 30419.847900760353, 30478.390432191674, 30835.383292334478, 30980.69019309778, 31168.376632467676, 24451.510969780862, 30642.846785765927, 30935.845320773253, 31234.21914452157, 32124.518132227568, 31433.0, 31513.21216969594, 31659.84170079227, 31921.201969950936, 38187.2362552753, 27491.31271718223, 28591.714082858904, 30128.397432051675, 30130.397392052473, 30325.848370758005, 23573.646395304426, 23664.31225654749, 23823.285301440985, 23991.760082398952, 24002.39994000094], "unit": "ms", "name": "ext.html", "value": 16978.82871625956}, {"lowerIsBetter": false, "replicates": [261.3479368974409, 264.6097006914801, 269.63599141159426, 276.0999142794489, 284.8077547655332, 10367.896321036787, 15617.219139043045, 16288.26702798374, 16293.348266069373, 16339.18304084797, 14668.486602968898, 14949.103053816778, 15059.924700376483, 15486.303116359762, 15501.147436890966, 5572.58205634578, 5729.828105156831, 5763.884722305552, 5774.133879918004, 5775.855603609902, 5681.914771278434, 5720.056190728525, 5722.62802917809, 5726.828195154152, 5735.2544169257935, 4088.7546747195115, 4124.835006599732, 5584.553235741131, 5746.511546518551, 6424.2290925089055, 6579.638119903403, 6589.604623722592, 6596.736130554772, 6624.933750662504, 6626.072349871022, 6185.103160041814, 6371.789360021581, 6380.872382552323, 6387.265464471552, 6391.137196478462, 20125.0, 20197.697034544493, 20470.38588842322, 20689.379318620464, 20696.0, 1704.4460550321196, 1731.480555833245, 1767.6199617082389, 1841.2634946021565, 1987.4137129546818, 8500.319974402033, 8684.044755076937, 8690.739277821676, 8818.735437936872, 8863.069377715376, 1674.8073971493313, 1678.991605041967, 1691.6532110917233, 1732.7920649522011, 1764.4442000769716, 51391.48608513942, 54557.45442545563, 54854.45145548533, 54865.451345486435, 54958.0, 9659.758506037406, 9692.903070969342, 9717.902820971842, 9731.708048758548, 9770.0, 12045.277283363026, 12070.758584828254, 12070.939645301718, 12086.456109475095, 12100.092493063055, 6836.760713375008, 6907.7236910524025, 6958.582485050913, 7012.158540975116, 7035.050268213828, 6674.5327827052615, 6739.696713647898, 6760.290169532128, 6768.2216545097945, 6786.253512113663, 4032.7983600819844, 4033.9596604033586, 4043.636072753466, 4111.951452379624, 4145.564715704868, 1561.73450513413, 1614.1687031178951, 1616.0546080542779, 1640.4832477769464, 1710.803257625364, 321.08810976825924, 342.48456073609555, 346.9011331770484, 801.6352559585491, 827.0943317067802, 8739.169778870997, 9033.41282816628, 9035.774105647411, 15415.691686166214, 15746.133962631937, 710.7583421636565, 801.2908575910361, 826.8098337382436, 827.3670641958906, 851.5231470376485, 8301.501909885426, 8431.451955622864, 8624.698135565224, 9203.815923681488, 9551.522423878778, 465512.0, 466200.0, 477002.0, 483075.0, 483679.0, 69549.65225173841, 73489.26510734932, 73594.0, 73952.26047739561, 74099.0, 1022.99488502557, 1073.3398959639921, 1077.4612693653173, 1081.691717860406, 1089.8528698625742, 13879.195704558342, 13889.722205556034, 14496.565103046925, 14688.310844253048, 14734.336954837272, 32711.0, 32889.34221315608, 32894.17764555905, 33226.83386583148, 33818.32363352768, 40622.39066414065, 41074.58925410827, 41106.794466028674, 42242.0, 42530.0, 7991.120976692443, 8324.292435143081, 8331.041930178108, 8360.749177524684, 8361.874571881548, 9670.274729395464, 9710.271729620166, 10289.84565231537, 15375.923120384774, 15481.0, 12979.545715899898, 13252.271125088213, 13364.665883352605, 13391.723407020634, 13479.32603369808, 11860.881391185978, 12220.45007974661, 12260.632181034583, 12524.686882828002, 12902.80645790295, 13379.665508362368, 13527.458901644217, 13553.796693049415, 13748.037637365289, 13994.37025333842, 8038.196180381915, 8047.436679432618, 8059.153788852086, 8289.751307460785, 8465.661373545236, 11589.24669896454, 13187.208767473981, 13203.273819939996, 13351.465941362625, 13851.86148138546], "unit": "ms", "name": "jquery.html", "value": 8024.87016112947}, {"lowerIsBetter": false, "replicates": [1414.5261337451952, 1537.454203757666, 1539.276540026188, 1566.0368873143018, 1633.4609578838983, 5932.436418540237, 6771.796846094619, 6973.6513174341335, 6978.720851165947, 6987.231404545502, 6687.929931211007, 6872.312768723138, 6872.828179295508, 6891.173059232887, 6894.965525172367, 1966.803319668036, 1978.0406502846108, 1987.592543528573, 1989.3037436897116, 1990.452625527984, 2001.059502034049, 2007.076744697441, 2023.757149142105, 2095.3818623506027, 2098.779628139039, 2011.668074767669, 2032.573159636478, 2058.4133521946246, 2058.7014882841977, 2060.608484387969, 2034.7965203479682, 2052.6305265052283, 2056.0953180600486, 2064.9881558036604, 2068.2864411777914, 2035.6335859545277, 2059.6807494838176, 2076.9480762980897, 2077.8649387789897, 2078.5011597216712, 6836.179658441019, 6898.379145876896, 6899.827504312382, 6909.378155965987, 6915.239323674442, 3897.2400381925536, 3954.5649978502342, 3954.683625309968, 3956.960430395688, 3968.8809335719975, 2663.5471969765185, 2675.2241849863517, 2717.7825773938234, 2731.085086496026, 2734.4257705881787, 786.4219798448136, 804.1395706593947, 851.5699571716306, 852.6845067325067, 1751.4132765523566, 9031.32265080115, 9172.266218702487, 9190.310726695458, 9221.446713197229, 9231.90768092324, 3523.806190659487, 3540.8583656653445, 3545.840437180333, 3605.8737944171826, 3781.300459414962, 8241.50550966944, 8247.463914845515, 8257.05959099623, 8268.0, 8326.916730832614, 4198.181354635817, 4198.538160802309, 4207.579242075829, 4220.873373798791, 4225.809838557272, 3136.059182245317, 3170.651228364878, 3595.2989167112164, 3805.6955443564448, 3810.1617644118805, 3331.3670402623907, 3397.7621566490106, 3400.387930172593, 3420.3159368125976, 3426.7258619310396, 1056.8309070548676, 1080.9675709728722, 1085.2294870641933, 1092.2463500184847, 1095.4851219926622, 1040.8282633365561, 1062.4262898034974, 1139.840422340873, 1161.3322339654733, 1163.8603367595774, 6531.706073226716, 6559.114519539897, 6568.441682456949, 6591.044298576776, 6609.735610575619, 1076.6447072466067, 1108.130117857478, 1123.168855047259, 1135.2734250079955, 1143.451143451148, 4985.825496107619, 5013.323201367769, 5039.949600504021, 5055.469175736494, 5056.06462804375, 7916.802079948047, 8030.718924837603, 8278.213569710868, 8278.751637450887, 8293.33653307734, 8182.345412366996, 8198.0, 8243.340532757366, 8251.463654862415, 8254.669813207405, 6548.869022619616, 6684.431823294977, 6734.393904548712, 6794.76218332356, 6825.1809782825385, 6314.810555683337, 6337.302896681269, 6345.7144428499905, 6354.23749150105, 6372.394622510854, 7507.099148102263, 7583.0, 7600.201978792147, 7652.426068044808, 7668.731594394169, 7701.075870895528, 7747.845043098993, 7807.0, 7846.646900889359, 7847.764567062997, 4978.178600530872, 5045.419776725724, 5827.388124246893, 5909.674967876808, 5910.940890591039, 6393.808185754435, 6494.870102597827, 6503.544751867324, 6534.901976470262, 6548.967255163694, 6009.188759517409, 6071.0, 6080.604760690541, 6177.166082578794, 6323.336049714714, 5991.64050156992, 6027.36712645166, 6074.635521868702, 6099.3290738017895, 6114.633122012693, 6163.722632481459, 6348.333424990495, 6379.585326953733, 6384.968075159594, 6388.93611063902, 5616.1014237721765, 5862.12068189775, 5862.7654893805475, 5865.090910908816, 5866.120081987736, 5860.413958604106, 5929.110633405024, 5934.228550288435, 5961.970190149022, 5986.132010858489], "unit": "ms", "name": "mootools.html", "value": 4018.665489719567}, {"lowerIsBetter": false, "replicates": [251.9861407622581, 255.19994816251048, 258.1674101024197, 259.0467081141399, 259.22620976385485, 5290.497402746738, 5313.149896016638, 5319.441458646839, 5344.4922732340465, 5377.784888604451, 4706.505816889228, 5035.244713292998, 5051.797928082881, 5084.38987321521, 5263.4472830515, 3943.940840887382, 3982.084120652252, 3983.721139520235, 3996.1807829395048, 3997.240524300388, 3980.3233450313373, 3985.681145508367, 3986.6013398660193, 3988.9401658974994, 3990.461287726149, 3767.321882061228, 3832.405977073558, 3873.8063096845044, 3911.8435262589464, 3949.8617548385814, 3943.2902077626018, 3943.881683549498, 3948.506436695413, 3954.6440820326306, 3955.1496428267915, 3387.2040070583394, 3391.7625766196375, 3395.134240768613, 3401.4557670772806, 3405.9489107663403, 5125.564327032207, 5127.410347810012, 5129.281900533928, 5130.948690513084, 5143.794248230066, 4458.643308535309, 4539.273716205391, 4552.840650577214, 4553.590176884063, 4556.407667003268, 5553.8333849984165, 5556.027695153372, 5558.749856256478, 5561.833145005657, 5567.47109024642, 3716.684081853046, 3719.7210209234145, 3721.0511319613324, 3723.4228694552116, 3731.197792474631, 5855.560832937546, 5860.945029894618, 5865.354810970833, 5866.090755932837, 5866.178734977064, 3620.7827530347736, 3810.580836108026, 3811.0662887592716, 3815.6756675682877, 3817.7783109405277, 3830.8467661293794, 3835.1562656215588, 3835.9642896417813, 3837.2901013312626, 3837.9808100959876, 4511.436070491189, 4513.751743654065, 4515.029268707243, 4518.480374756879, 4519.593236608721, 5589.35722391922, 5598.076317407664, 5599.188117722989, 5600.467955544217, 5603.047481928001, 1316.0261406559268, 1325.648703093681, 1327.230206480239, 1327.7543654423962, 1328.103530117167, 865.4244927123518, 871.1419252036738, 878.5255961780567, 891.6522556203086, 892.9374943754004, 4912.926306105412, 4914.0908931847725, 4918.040982008545, 4919.7540122993705, 4920.065187614342, 5820.941790582125, 5827.854303642443, 5832.329282132524, 5832.3292821326095, 5833.649981001154, 4728.030753695484, 4912.263160525878, 4915.705057696549, 4916.410030796327, 4916.532929371704, 3032.651245106797, 3059.3728285701377, 3143.0727935258697, 3144.8427578621436, 3153.716165545112, 5475.0, 5488.780448782084, 5492.862678433071, 5495.258140151029, 5497.862553436116, 6002.249718785152, 6004.729787159588, 6008.429199226067, 6013.939860601338, 6016.42843929826, 5378.2470454136455, 5450.0, 5481.945180548223, 5492.148716948959, 5494.313210848644, 5829.3296270927685, 5853.853653658693, 5861.120831875252, 5864.413558644102, 5864.912026319524, 5716.657000579979, 5721.57088218377, 5728.341240757366, 5734.0, 5736.19693242938, 5329.1206950852675, 5482.068048431856, 5483.177523371526, 5485.149801780731, 5485.670859748428, 3753.793541355142, 3783.2244389900557, 3785.072657199004, 3789.5073640426567, 3791.9052023698523, 5794.13088036781, 5837.270341207349, 5849.034909239927, 5855.473007429352, 5860.941390586039, 5608.635438696471, 5615.129654903497, 5626.634268772516, 5632.9436705632415, 5633.464820842013, 5444.101723215784, 5610.298712660918, 5646.153077038477, 5652.915206271991, 5665.178549110274, 5537.944620553743, 5539.0, 5547.972260138674, 5548.528375088163, 5553.4724201200825, 5698.515626171656, 5702.885942281214, 5703.686297253691, 5705.343885453226, 5707.315122185364, 5419.536725084126, 5555.2778138843305, 5556.972215138899, 5559.305086864142, 5568.136938774496], "unit": "ms", "name": "prototype.html", "value": 4104.186939241274}, {"lowerIsBetter": false, "replicates": [644.6357807838571, 664.9268580456151, 693.6878404717878, 729.7044696897758, 755.9190357788362, 11507.482163302651, 11751.412429378539, 11786.233894796833, 11824.231424957372, 11826.526938922454, 11344.262622929504, 12144.635660930164, 12261.693457663541, 12268.693282667939, 12294.262344259329, 621.4748537485817, 629.5655997361829, 779.863523883321, 784.9293563579276, 796.41861441148, 799.3924617290843, 801.5591424716412, 803.8673618852882, 807.1363640904235, 807.2895851650569, 834.1241696218976, 841.6212704283066, 841.8737189421574, 842.048485211713, 842.2377748137945, 648.5006544960402, 656.1142457682139, 825.2078005115096, 839.4249938791886, 842.1031601344548, 621.6922623301449, 621.7450845153511, 621.7948077134535, 621.8196722950339, 621.9284782250054, 11785.528578856836, 11941.462634181396, 11972.281663100155, 11974.521019159223, 11981.580644677395, 11051.226414151013, 11589.884101158965, 11706.12204084697, 11785.175037747362, 12015.0, 9490.620375184984, 9695.854562181574, 9762.707118786448, 9766.560504777302, 9824.361416507976, 3248.4477638801222, 3253.7722359434847, 3267.57521522203, 3300.042987533612, 3366.023853082603, 36618.81690591557, 36799.264014719556, 36891.4466283006, 37051.62948370509, 37184.0, 8864.73405797827, 9061.59222834974, 9069.54652267384, 9214.539273036322, 9424.811503769886, 15813.0, 15823.367065317489, 15846.76229856553, 15869.285882135331, 15886.443974460839, 6190.473809726133, 6253.280872699606, 6324.2410910691015, 6362.236531616236, 6553.901691474632, 3472.5138480612736, 3490.406630872758, 3566.037169964095, 3566.0906468850794, 3580.4092324766643, 2604.0104760191007, 2620.3842097107163, 2624.4882247961846, 2638.630591717161, 2639.934001649974, 479.0706030301204, 485.1921550618252, 498.76558017731605, 502.7335512178551, 504.3216873305398, 546.1998172677047, 549.0994768579533, 562.3476766950399, 565.9858503537445, 577.5495113811234, 7520.247975202546, 7524.209957954336, 7584.62076896153, 8022.077461092049, 8062.355011599058, 457.8397560853741, 550.2544052808466, 571.1033677126954, 609.765240382456, 617.219217689623, 3207.3264614430764, 3445.5693038370205, 3533.8939831805087, 3560.359135355609, 3913.0, 46690.29964550534, 47290.76354618205, 47460.52539474561, 47619.76190119096, 54809.72595137078, 42049.369259461135, 42196.57803421988, 42235.57764422378, 42525.57474425216, 42951.14097718028, 38163.0, 38303.233935321136, 38614.0, 38739.225215495535, 39048.21903561913, 7476.4392670551015, 8006.83986320282, 8108.918910810817, 8150.673973041012, 8221.588920554068, 29815.85092074526, 30363.696363036088, 30710.0, 30730.385392292475, 30869.69130308668, 34869.0, 35264.0, 38169.80915095518, 38312.616873830906, 38892.80553597214, 9505.0, 9520.285978551776, 9687.806243875224, 9753.853692194481, 9944.0, 10771.6229931952, 10852.837207442053, 11066.280691755332, 11440.0, 11742.236754610924, 9927.453990030328, 9957.850632240667, 10018.699439016842, 10184.949075254577, 10311.793764124826, 10073.244506661884, 10073.445960472245, 10090.596376144871, 10186.185105191715, 10276.22928280367, 10152.289339746147, 10222.080012798884, 10250.743731406774, 10253.692389228336, 10295.94852025735, 8908.5991130398, 8956.193942545202, 9251.96165638829, 9313.301502387483, 9828.950855245677, 8506.043609969865, 8935.419197752126, 9074.682386116454, 9148.954255228682, 9171.174594286545], "unit": "ms", "name": "yui.html", "value": 5611.073042727266}], "name": "dromaeo_css", "value": 6221.248145809585}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 112.0, 106.0, 111.0, 112.0, 111.0, 102.0, 112.0, 112.0, 103.0], "unit": "ms", "name": "ai-astar", "value": 109.0}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 152.0, 167.0, 129.0, 152.0, 148.0, 135.0, 178.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.8}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 160.0, 161.0, 163.0, 161.0, 161.0, 161.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 88.0, 93.0, 72.0, 72.0, 72.0, 93.0, 88.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [94.0, 95.0, 128.0, 94.0, 95.0, 94.0, 125.0, 94.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 104.4}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.3}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 147.0, 146.0, 146.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.6}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 73.0, 72.0, 73.0, 72.0, 74.0, 72.0, 73.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 72.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [83.0, 91.0, 85.0, 86.0, 86.0, 85.0, 85.0, 89.0, 86.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [129.0, 127.0, 126.0, 126.0, 117.0, 125.0, 128.0, 126.0, 123.0, 127.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.4}, {"lowerIsBetter": true, "replicates": [138.0, 142.0, 150.0, 153.0, 158.0, 146.0, 148.0, 141.0, 145.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 69.0, 68.0, 68.0, 67.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.6}], "name": "kraken", "value": 1519.5}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [172.4435247456458], "unit": "score", "name": "Richards", "value": 204.71629799999994}, {"lowerIsBetter": false, "replicates": [186.77624206200971], "unit": "score", "name": "DeltaBlue", "value": 353.9957719999998}, {"lowerIsBetter": false, "replicates": [278.6291446085261], "unit": "score", "name": "Encrypt", "value": 955.3236090000001}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2006.0120240480962], "unit": "score", "name": "RayTrace", "value": 368.8856253746253}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26921.052631578947], "unit": "score", "name": "RegExp", "value": 33.83913000977518}, {"lowerIsBetter": false, "replicates": [597.9869745411486], "unit": "score", "name": "Splay", "value": 136.2755435643564}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19713.348050891083}]} 04:34:51 INFO - RETURN: dromaeo_css: 6221.25 04:34:51 INFO - RETURN: kraken: 1519.50 04:34:51 INFO - RETURN: v8_7: 19713.35 04:34:51 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19713.35"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1519.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6221.25"}}} 04:34:51 INFO - Return code: 0 04:34:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:34:51 ERROR - # TBPL SUCCESS # 04:34:51 INFO - Running post-action listener: _resource_record_post_action 04:34:51 INFO - Running post-run listener: _resource_record_post_run 04:34:52 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 143360; Write bytes: 508702720; Read time: 416; Write time: 414344 04:34:52 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 110592; Write bytes: 232144896; Read time: 200; Write time: 284688 04:34:52 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 32768; Write bytes: 276557824; Read time: 216; Write time: 129656 04:34:52 INFO - Running post-run listener: _upload_blobber_files 04:34:52 INFO - Blob upload gear active. 04:34:52 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:34:52 INFO - Copying logs to upload dir... 04:34:52 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1287.043500 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2015-12-09 04:34:52.669619) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:52.672875) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009964 build_url: 'https://queue.taskcluster.net/v1/task/TmOKfccUSS6dZTBIdP6Jjg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:52.726923) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:52.727605) ========= 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=dd132779db58144225c4cf24000001c8-1449656869.227650-1071286004 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004584 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 04:34:52.778250) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:34:52.778592) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 04:34:52.778921) ========= ========= Total master_lag: 0.23 =========