builder: mozilla-central_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-039 starttime: 1449546445.01 results: success (0) buildid: 20151207183223 builduid: 941776fe93ea4c39b6ef2c62a7d8d6d6 revision: d08afef8b42d1f481dc5f9cca8df35ed0a848836 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.012560) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.015636) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.015974) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006370 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.046834) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.047148) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.064174) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.064592) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 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 -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.116814) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.117128) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.117552) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.117875) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 19:47:26-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 36.3M=0s 2015-12-07 19:47:26 (36.3 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.112946 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.246055) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.246381) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022254 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.297809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.298496) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev d08afef8b42d1f481dc5f9cca8df35ed0a848836 --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 d08afef8b42d1f481dc5f9cca8df35ed0a848836 --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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 19:47:26,518 truncating revision to first 12 chars 2015-12-07 19:47:26,518 Setting DEBUG logging. 2015-12-07 19:47:26,518 attempt 1/10 2015-12-07 19:47:26,518 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/d08afef8b42d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-07 19:47:26,757 unpacking tar archive at: mozilla-central-d08afef8b42d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.525871 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.844807) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.845331) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.857762) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.858275) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 19:47:25.858978) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-07 19:47:25.859900) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:47:27 INFO - MultiFileLogger online at 20151207 19:47:27 in /builds/slave/test 19:47:27 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 19:47:27 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:47:27 INFO - {'append_to_log': False, 19:47:27 INFO - 'base_work_dir': '/builds/slave/test', 19:47:27 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 19:47:27 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:47:27 INFO - 'branch': 'Firefox-Non-PGO', 19:47:27 INFO - 'buildbot_json_path': 'buildprops.json', 19:47:27 INFO - 'config_files': ('talos/linux_config.py',), 19:47:27 INFO - 'default_actions': ('clobber', 19:47:27 INFO - 'read-buildbot-config', 19:47:27 INFO - 'download-and-extract', 19:47:27 INFO - 'populate-webroot', 19:47:27 INFO - 'create-virtualenv', 19:47:27 INFO - 'install', 19:47:27 INFO - 'run-tests'), 19:47:27 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:47:27 INFO - 'download_minidump_stackwalk': True, 19:47:27 INFO - 'download_symbols': 'ondemand', 19:47:27 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:47:27 INFO - 'tooltool.py': '/tools/tooltool.py', 19:47:27 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:47:27 INFO - '/tools/misc-python/virtualenv.py')}, 19:47:27 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:47:27 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:47:27 INFO - 'installer_path': 'installer.exe', 19:47:27 INFO - 'log_level': 'info', 19:47:27 INFO - 'log_name': 'talos', 19:47:27 INFO - 'log_to_console': True, 19:47:27 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:47:27 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:47:27 INFO - 'opt_config_files': (), 19:47:27 INFO - 'pip_index': False, 19:47:27 INFO - 'sps_profile': False, 19:47:27 INFO - 'sps_profile_interval': 0, 19:47:27 INFO - 'suite': 'dromaeojs-e10s', 19:47:27 INFO - 'system_bits': '64', 19:47:27 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:47:27 INFO - 'title': 'talos-linux64-ix-039', 19:47:27 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:47:27 INFO - 'use_talos_json': True, 19:47:27 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:47:27 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:47:27 INFO - 'work_dir': 'build'} 19:47:27 INFO - ##### 19:47:27 INFO - ##### Running clobber step. 19:47:27 INFO - ##### 19:47:27 INFO - Running pre-action listener: _resource_record_pre_action 19:47:27 INFO - Running main action method: clobber 19:47:27 INFO - rmtree: /builds/slave/test/build 19:47:27 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:47:28 INFO - Running post-action listener: _resource_record_post_action 19:47:28 INFO - ##### 19:47:28 INFO - ##### Running read-buildbot-config step. 19:47:28 INFO - ##### 19:47:28 INFO - Running pre-action listener: _resource_record_pre_action 19:47:28 INFO - Running main action method: read_buildbot_config 19:47:28 INFO - Using buildbot properties: 19:47:28 INFO - { 19:47:28 INFO - "properties": { 19:47:28 INFO - "buildnumber": 137, 19:47:28 INFO - "product": "firefox", 19:47:28 INFO - "script_repo_revision": "production", 19:47:28 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs-e10s", 19:47:28 INFO - "repository": "", 19:47:28 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs-e10s", 19:47:28 INFO - "buildid": "20151207183223", 19:47:28 INFO - "slavename": "talos-linux64-ix-039", 19:47:28 INFO - "pgo_build": "False", 19:47:28 INFO - "basedir": "/builds/slave/test", 19:47:28 INFO - "project": "", 19:47:28 INFO - "platform": "ubuntu64_hw", 19:47:28 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 19:47:28 INFO - "slavebuilddir": "test", 19:47:28 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 19:47:28 INFO - "branch": "mozilla-central", 19:47:28 INFO - "repo_path": "mozilla-central", 19:47:28 INFO - "stage_platform": "linux64", 19:47:28 INFO - "builduid": "941776fe93ea4c39b6ef2c62a7d8d6d6", 19:47:28 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:47:28 INFO - }, 19:47:28 INFO - "sourcestamp": { 19:47:28 INFO - "repository": "", 19:47:28 INFO - "hasPatch": false, 19:47:28 INFO - "project": "", 19:47:28 INFO - "branch": "mozilla-central-linux64-talos", 19:47:28 INFO - "changes": [ 19:47:28 INFO - { 19:47:28 INFO - "category": null, 19:47:28 INFO - "files": [ 19:47:28 INFO - { 19:47:28 INFO - "url": null, 19:47:28 INFO - "name": "https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:47:28 INFO - } 19:47:28 INFO - ], 19:47:28 INFO - "repository": "", 19:47:28 INFO - "rev": "d08afef8b42d1f481dc5f9cca8df35ed0a848836", 19:47:28 INFO - "who": "philringnalda@gmail.com", 19:47:28 INFO - "when": 1449546366, 19:47:28 INFO - "number": 7015785, 19:47:28 INFO - "comments": "Bug 1162813: filter paragraph separators before passing text to SetPara, r=jfkthame", 19:47:28 INFO - "project": "", 19:47:28 INFO - "at": "Mon 07 Dec 2015 19:46:06", 19:47:28 INFO - "branch": "mozilla-central-linux64-talos", 19:47:28 INFO - "revlink": "", 19:47:28 INFO - "properties": [ 19:47:28 INFO - [ 19:47:28 INFO - "buildid", 19:47:28 INFO - "20151207183223", 19:47:28 INFO - "Change" 19:47:28 INFO - ], 19:47:28 INFO - [ 19:47:28 INFO - "builduid", 19:47:28 INFO - "941776fe93ea4c39b6ef2c62a7d8d6d6", 19:47:28 INFO - "Change" 19:47:28 INFO - ], 19:47:28 INFO - [ 19:47:28 INFO - "pgo_build", 19:47:28 INFO - "False", 19:47:28 INFO - "Change" 19:47:28 INFO - ] 19:47:28 INFO - ], 19:47:28 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:47:28 INFO - } 19:47:28 INFO - ], 19:47:28 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:47:28 INFO - } 19:47:28 INFO - } 19:47:28 INFO - Found installer url https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:47:28 INFO - Running post-action listener: _resource_record_post_action 19:47:28 INFO - ##### 19:47:28 INFO - ##### Running download-and-extract step. 19:47:28 INFO - ##### 19:47:28 INFO - Running pre-action listener: _resource_record_pre_action 19:47:28 INFO - Running main action method: download_and_extract 19:47:28 INFO - mkdir: /builds/slave/test/build/tests 19:47:28 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')]} 19:47:28 INFO - https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:47:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/test_packages.json 19:47:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/test_packages.json 19:47:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:47:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:47:34 INFO - Downloaded 1302 bytes. 19:47:34 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:47:34 INFO - Using the following test package requirements: 19:47:34 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:34 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:47:34 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'jsshell-linux-x86_64.zip'], 19:47:34 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:47:34 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:34 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:47:34 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:47:34 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:47:34 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:47:34 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:47:34 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:47:34 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:47:34 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')]} 19:47:34 INFO - https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:47:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:37 INFO - Downloaded 21860094 bytes. 19:47:37 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:47:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:37 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:47:38 INFO - Return code: 0 19:47:38 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 19:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:38 INFO - https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:47:38 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:38 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:38 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:45 INFO - Downloaded 21860094 bytes. 19:47:45 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 19:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:47:45 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 19:47:46 INFO - Return code: 0 19:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:46 INFO - https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:47:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:47 INFO - Downloaded 11132074 bytes. 19:47:47 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 19:47:47 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:47:47 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 19:47:47 INFO - Return code: 0 19:47:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:47 INFO - https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:47:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:47:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:47:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/GXOGNOn2TWCNKwY3f5crqA/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 19:47:49 INFO - Downloaded 57726957 bytes. 19:47:49 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:47:49 INFO - mkdir: /builds/slave/test/properties 19:47:49 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:47:49 INFO - Writing to file /builds/slave/test/properties/build_url 19:47:49 INFO - Contents: 19:47:49 INFO - build_url:https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:47:49 INFO - Running post-action listener: _resource_record_post_action 19:47:49 INFO - Running post-action listener: set_extra_try_arguments 19:47:49 INFO - ##### 19:47:49 INFO - ##### Running populate-webroot step. 19:47:49 INFO - ##### 19:47:49 INFO - Running pre-action listener: _resource_record_pre_action 19:47:49 INFO - Running main action method: populate_webroot 19:47:49 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:47:49 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:47:49 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:47:49 INFO - '../fennec_ids.txt'], 19:47:49 INFO - 'tests': ['tcheck2']}, 19:47:49 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:47:49 INFO - '--tppagecycles', 19:47:49 INFO - '7'], 19:47:49 INFO - 'tests': ['tsvgm']}}, 19:47:49 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:47:49 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:47:49 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:49 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:47:49 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:49 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:47:49 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'tests': ['damp', 'tps']}, 19:47:49 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['damp', 'tps']}, 19:47:49 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:47:49 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:47:49 INFO - 'other': {'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'other_l64': {'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'other_nol64': {'tests': ['a11yr', 19:47:49 INFO - 'ts_paint', 19:47:49 INFO - 'tpaint', 19:47:49 INFO - 'sessionrestore', 19:47:49 INFO - 'sessionrestore_no_auto_restore']}, 19:47:49 INFO - 'svgr': {'tests': ['tsvgx', 19:47:49 INFO - 'tsvgr_opacity', 19:47:49 INFO - 'tart', 19:47:49 INFO - 'tscrollx', 19:47:49 INFO - 'cart']}, 19:47:49 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['tsvgx', 19:47:49 INFO - 'tsvgr_opacity', 19:47:49 INFO - 'tart', 19:47:49 INFO - 'tscrollx', 19:47:49 INFO - 'cart']}, 19:47:49 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'tests': ['tp5o']}, 19:47:49 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'talos_options': ['--e10s'], 19:47:49 INFO - 'tests': ['tp5o']}, 19:47:49 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'talos_options': ['--xperf_path', 19:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:49 INFO - 'tests': ['tp5n']}, 19:47:49 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:47:49 INFO - 'talos_options': ['--e10s', 19:47:49 INFO - '--xperf_path', 19:47:49 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:47:49 INFO - 'tests': ['tp5n']}}, 19:47:49 INFO - 'talos.zip': {'path': '', 19:47:49 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:47:49 INFO - Running post-action listener: _resource_record_post_action 19:47:49 INFO - ##### 19:47:49 INFO - ##### Running create-virtualenv step. 19:47:49 INFO - ##### 19:47:49 INFO - Running pre-action listener: _resource_record_pre_action 19:47:49 INFO - Running main action method: create_virtualenv 19:47:49 INFO - Creating virtualenv /builds/slave/test/build/venv 19:47:49 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 19:47:49 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:47:50 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:47:50 INFO - Using real prefix '/usr' 19:47:50 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:47:50 INFO - Installing distribute.............................................................................................................................................................................................done. 19:47:52 INFO - Installing pip.................done. 19:47:52 INFO - Return code: 0 19:47:52 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 19:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 19:47:52 INFO - Using env: {'DISPLAY': ':0', 19:47:52 INFO - 'HOME': '/home/cltbld', 19:47:52 INFO - 'LANG': 'en_US.UTF-8', 19:47:52 INFO - 'LANGUAGE': 'en_US:en', 19:47:52 INFO - 'LOGNAME': 'cltbld', 19:47:52 INFO - 'MAIL': '/var/mail/cltbld', 19:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:52 INFO - 'MOZ_NO_REMOTE': '1', 19:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:52 INFO - 'NO_EM_RESTART': '1', 19:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:52 INFO - 'PWD': '/builds/slave/test', 19:47:52 INFO - 'SHELL': '/bin/bash', 19:47:52 INFO - 'SHLVL': '1', 19:47:52 INFO - 'TERM': 'linux', 19:47:52 INFO - 'TMOUT': '86400', 19:47:52 INFO - 'USER': 'cltbld', 19:47:52 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:52 INFO - '_': '/tools/buildbot/bin/python'} 19:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 19:47:52 INFO - Cleaning up... 19:47:52 INFO - Return code: 0 19:47:52 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:47:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 19:47:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 19:47:52 INFO - Using env: {'DISPLAY': ':0', 19:47:52 INFO - 'HOME': '/home/cltbld', 19:47:52 INFO - 'LANG': 'en_US.UTF-8', 19:47:52 INFO - 'LANGUAGE': 'en_US:en', 19:47:52 INFO - 'LOGNAME': 'cltbld', 19:47:52 INFO - 'MAIL': '/var/mail/cltbld', 19:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:52 INFO - 'MOZ_NO_REMOTE': '1', 19:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:52 INFO - 'NO_EM_RESTART': '1', 19:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:52 INFO - 'PWD': '/builds/slave/test', 19:47:52 INFO - 'SHELL': '/bin/bash', 19:47:52 INFO - 'SHLVL': '1', 19:47:52 INFO - 'TERM': 'linux', 19:47:52 INFO - 'TMOUT': '86400', 19:47:52 INFO - 'USER': 'cltbld', 19:47:52 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:52 INFO - '_': '/tools/buildbot/bin/python'} 19:47:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:52 INFO - Downloading/unpacking psutil>=0.7.1 19:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:54 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:47:54 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:54 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:54 INFO - Installing collected packages: psutil 19:47:54 INFO - Running setup.py install for psutil 19:47:54 INFO - building 'psutil._psutil_linux' extension 19:47:54 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 19:47:54 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 19:47:55 INFO - building 'psutil._psutil_posix' extension 19:47:55 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 19:47:55 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 19:47:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:47:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:47:55 INFO - Successfully installed psutil 19:47:55 INFO - Cleaning up... 19:47:55 INFO - Return code: 0 19:47:55 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:55 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 19:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 19:47:55 INFO - Using env: {'DISPLAY': ':0', 19:47:55 INFO - 'HOME': '/home/cltbld', 19:47:55 INFO - 'LANG': 'en_US.UTF-8', 19:47:55 INFO - 'LANGUAGE': 'en_US:en', 19:47:55 INFO - 'LOGNAME': 'cltbld', 19:47:55 INFO - 'MAIL': '/var/mail/cltbld', 19:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:55 INFO - 'MOZ_NO_REMOTE': '1', 19:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:55 INFO - 'NO_EM_RESTART': '1', 19:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:55 INFO - 'PWD': '/builds/slave/test', 19:47:55 INFO - 'SHELL': '/bin/bash', 19:47:55 INFO - 'SHLVL': '1', 19:47:55 INFO - 'TERM': 'linux', 19:47:55 INFO - 'TMOUT': '86400', 19:47:55 INFO - 'USER': 'cltbld', 19:47:55 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:55 INFO - '_': '/tools/buildbot/bin/python'} 19:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:55 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:57 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:47:57 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 19:47:57 INFO - Installing collected packages: mozsystemmonitor 19:47:57 INFO - Running setup.py install for mozsystemmonitor 19:47:57 INFO - Successfully installed mozsystemmonitor 19:47:57 INFO - Cleaning up... 19:47:57 INFO - Return code: 0 19:47:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:47: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')]} 19:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:47:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47: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')]} 19:47:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:47:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:47:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:47:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:47:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:47:57 INFO - Using env: {'DISPLAY': ':0', 19:47:57 INFO - 'HOME': '/home/cltbld', 19:47:57 INFO - 'LANG': 'en_US.UTF-8', 19:47:57 INFO - 'LANGUAGE': 'en_US:en', 19:47:57 INFO - 'LOGNAME': 'cltbld', 19:47:57 INFO - 'MAIL': '/var/mail/cltbld', 19:47:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:47:57 INFO - 'MOZ_NO_REMOTE': '1', 19:47:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:47:57 INFO - 'NO_EM_RESTART': '1', 19:47:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:47:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:47:57 INFO - 'PWD': '/builds/slave/test', 19:47:57 INFO - 'SHELL': '/bin/bash', 19:47:57 INFO - 'SHLVL': '1', 19:47:57 INFO - 'TERM': 'linux', 19:47:57 INFO - 'TMOUT': '86400', 19:47:57 INFO - 'USER': 'cltbld', 19:47:57 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:47:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:47:57 INFO - '_': '/tools/buildbot/bin/python'} 19:47:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:47:57 INFO - Downloading/unpacking blobuploader==1.2.4 19:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:59 INFO - Downloading blobuploader-1.2.4.tar.gz 19:47:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:47:59 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:59 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:47:59 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:47:59 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:00 INFO - Downloading docopt-0.6.1.tar.gz 19:48:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:48:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:48:00 INFO - Installing collected packages: blobuploader, requests, docopt 19:48:00 INFO - Running setup.py install for blobuploader 19:48:00 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:48:00 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:48:00 INFO - Running setup.py install for requests 19:48:00 INFO - Running setup.py install for docopt 19:48:00 INFO - Successfully installed blobuploader requests docopt 19:48:00 INFO - Cleaning up... 19:48:00 INFO - Return code: 0 19:48:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48: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')]} 19:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48: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')]} 19:48:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:48:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 19:48:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:48:00 INFO - Using env: {'DISPLAY': ':0', 19:48:00 INFO - 'HOME': '/home/cltbld', 19:48:00 INFO - 'LANG': 'en_US.UTF-8', 19:48:00 INFO - 'LANGUAGE': 'en_US:en', 19:48:00 INFO - 'LOGNAME': 'cltbld', 19:48:00 INFO - 'MAIL': '/var/mail/cltbld', 19:48:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:00 INFO - 'MOZ_NO_REMOTE': '1', 19:48:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:00 INFO - 'NO_EM_RESTART': '1', 19:48:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:00 INFO - 'PWD': '/builds/slave/test', 19:48:00 INFO - 'SHELL': '/bin/bash', 19:48:00 INFO - 'SHLVL': '1', 19:48:00 INFO - 'TERM': 'linux', 19:48:00 INFO - 'TMOUT': '86400', 19:48:00 INFO - 'USER': 'cltbld', 19:48:00 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:00 INFO - '_': '/tools/buildbot/bin/python'} 19:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:48:00 INFO - Running setup.py (path:/tmp/pip-7FqLk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:48:01 INFO - Running setup.py (path:/tmp/pip-hizZk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:48:01 INFO - Running setup.py (path:/tmp/pip-HLggs8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:48:01 INFO - Running setup.py (path:/tmp/pip-0B14vI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:48:01 INFO - Running setup.py (path:/tmp/pip-ywEhaC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:48:01 INFO - Running setup.py (path:/tmp/pip-EZCYTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:48:01 INFO - Running setup.py (path:/tmp/pip-nTcUZr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:48:01 INFO - Running setup.py (path:/tmp/pip-EJav35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:48:01 INFO - Running setup.py (path:/tmp/pip-WIm5jV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:48:01 INFO - Running setup.py (path:/tmp/pip-8dB7j6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:48:01 INFO - Running setup.py (path:/tmp/pip-O1VpDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:48:01 INFO - Running setup.py (path:/tmp/pip-YtAeXr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:48:01 INFO - Running setup.py (path:/tmp/pip-zLOH7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:48:01 INFO - Running setup.py (path:/tmp/pip-bk6M5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:01 INFO - Running setup.py (path:/tmp/pip-b2uTrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:48:02 INFO - Running setup.py (path:/tmp/pip-s6mvdR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:48:02 INFO - Running setup.py (path:/tmp/pip-T0UwIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:48:02 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:48:02 INFO - Running setup.py install for manifestparser 19:48:02 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:48:02 INFO - Running setup.py install for mozcrash 19:48:02 INFO - Running setup.py install for mozdebug 19:48:02 INFO - Running setup.py install for mozdevice 19:48:02 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:48:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:48:02 INFO - Running setup.py install for mozfile 19:48:02 INFO - Running setup.py install for mozhttpd 19:48:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:48:02 INFO - Running setup.py install for mozinfo 19:48:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:48:02 INFO - Running setup.py install for mozInstall 19:48:03 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Running setup.py install for mozleak 19:48:03 INFO - Running setup.py install for mozlog 19:48:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Running setup.py install for moznetwork 19:48:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Running setup.py install for mozprocess 19:48:03 INFO - Running setup.py install for mozprofile 19:48:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Running setup.py install for mozrunner 19:48:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Running setup.py install for mozscreenshot 19:48:03 INFO - Running setup.py install for moztest 19:48:03 INFO - Running setup.py install for mozversion 19:48:03 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:48:03 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 19:48:03 INFO - Cleaning up... 19:48:03 INFO - Return code: 0 19:48:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:04 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 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:48:04 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 19:48:04 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 19:48:04 INFO - Using env: {'DISPLAY': ':0', 19:48:04 INFO - 'HOME': '/home/cltbld', 19:48:04 INFO - 'LANG': 'en_US.UTF-8', 19:48:04 INFO - 'LANGUAGE': 'en_US:en', 19:48:04 INFO - 'LOGNAME': 'cltbld', 19:48:04 INFO - 'MAIL': '/var/mail/cltbld', 19:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:04 INFO - 'MOZ_NO_REMOTE': '1', 19:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:04 INFO - 'NO_EM_RESTART': '1', 19:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:04 INFO - 'PWD': '/builds/slave/test', 19:48:04 INFO - 'SHELL': '/bin/bash', 19:48:04 INFO - 'SHLVL': '1', 19:48:04 INFO - 'TERM': 'linux', 19:48:04 INFO - 'TMOUT': '86400', 19:48:04 INFO - 'USER': 'cltbld', 19:48:04 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:04 INFO - '_': '/tools/buildbot/bin/python'} 19:48:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:48:04 INFO - Running setup.py (path:/tmp/pip-pZSDBr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:48:04 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)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:48:04 INFO - Running setup.py (path:/tmp/pip-lXwVMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:48:04 INFO - Running setup.py (path:/tmp/pip-Pd4ngr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:48:04 INFO - Running setup.py (path:/tmp/pip-N4t1qN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:48:04 INFO - Running setup.py (path:/tmp/pip-uRbJJm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:48:04 INFO - Running setup.py (path:/tmp/pip-lk4hRn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:48:04 INFO - Running setup.py (path:/tmp/pip-TKyLNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:48:04 INFO - Running setup.py (path:/tmp/pip-kLPu_m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:48:04 INFO - Running setup.py (path:/tmp/pip-4E96JL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:48:04 INFO - Running setup.py (path:/tmp/pip-xHTA1s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:48:04 INFO - Running setup.py (path:/tmp/pip-DV5UYU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:48:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:48:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:48:04 INFO - Running setup.py (path:/tmp/pip-sR5CtD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:48:05 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)) 19:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:48:05 INFO - Running setup.py (path:/tmp/pip-wuFgBE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:48:05 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)) 19:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:48:05 INFO - Running setup.py (path:/tmp/pip-GNg8LK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:48:05 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)) 19:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:05 INFO - Running setup.py (path:/tmp/pip-kozV_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:48:05 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)) 19:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:48:05 INFO - Running setup.py (path:/tmp/pip-vwlPt9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 19:48:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:48:05 INFO - Running setup.py (path:/tmp/pip-DQjeIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:48:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:48:05 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:07 INFO - Downloading blessings-1.5.1.tar.gz 19:48:07 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 19:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 19:48:07 INFO - Installing collected packages: blessings 19:48:07 INFO - Running setup.py install for blessings 19:48:07 INFO - Successfully installed blessings 19:48:07 INFO - Cleaning up... 19:48:07 INFO - Return code: 0 19:48:07 INFO - Done creating virtualenv /builds/slave/test/build/venv. 19:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:48:07 INFO - Reading from file tmpfile_stdout 19:48:07 INFO - Current package versions: 19:48:07 INFO - argparse == 1.2.1 19:48:07 INFO - blessings == 1.5.1 19:48:07 INFO - blobuploader == 1.2.4 19:48:07 INFO - docopt == 0.6.1 19:48:07 INFO - manifestparser == 1.1 19:48:07 INFO - mozInstall == 1.12 19:48:07 INFO - mozcrash == 0.16 19:48:07 INFO - mozdebug == 0.1 19:48:07 INFO - mozdevice == 0.47 19:48:07 INFO - mozfile == 1.2 19:48:07 INFO - mozhttpd == 0.7 19:48:07 INFO - mozinfo == 0.9 19:48:07 INFO - mozleak == 0.1 19:48:07 INFO - mozlog == 3.1 19:48:07 INFO - moznetwork == 0.27 19:48:07 INFO - mozprocess == 0.22 19:48:07 INFO - mozprofile == 0.27 19:48:07 INFO - mozrunner == 6.11 19:48:07 INFO - mozscreenshot == 0.1 19:48:07 INFO - mozsystemmonitor == 0.0 19:48:07 INFO - moztest == 0.7 19:48:07 INFO - mozversion == 1.4 19:48:07 INFO - psutil == 3.1.1 19:48:07 INFO - requests == 1.2.3 19:48:07 INFO - wsgiref == 0.1.2 19:48:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 19:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 19:48:07 INFO - Using env: {'DISPLAY': ':0', 19:48:07 INFO - 'HOME': '/home/cltbld', 19:48:07 INFO - 'LANG': 'en_US.UTF-8', 19:48:07 INFO - 'LANGUAGE': 'en_US:en', 19:48:07 INFO - 'LOGNAME': 'cltbld', 19:48:07 INFO - 'MAIL': '/var/mail/cltbld', 19:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:07 INFO - 'MOZ_NO_REMOTE': '1', 19:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:07 INFO - 'NO_EM_RESTART': '1', 19:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:07 INFO - 'PWD': '/builds/slave/test', 19:48:07 INFO - 'SHELL': '/bin/bash', 19:48:07 INFO - 'SHLVL': '1', 19:48:07 INFO - 'TERM': 'linux', 19:48:07 INFO - 'TMOUT': '86400', 19:48:07 INFO - 'USER': 'cltbld', 19:48:07 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:07 INFO - '_': '/tools/buildbot/bin/python'} 19:48:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 19:48:07 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 19:48:07 INFO - Cleaning up... 19:48:07 INFO - Return code: 0 19:48:07 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 19:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:07 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:48:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 19:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 19:48:07 INFO - Using env: {'DISPLAY': ':0', 19:48:07 INFO - 'HOME': '/home/cltbld', 19:48:07 INFO - 'LANG': 'en_US.UTF-8', 19:48:07 INFO - 'LANGUAGE': 'en_US:en', 19:48:07 INFO - 'LOGNAME': 'cltbld', 19:48:07 INFO - 'MAIL': '/var/mail/cltbld', 19:48:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:07 INFO - 'MOZ_NO_REMOTE': '1', 19:48:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:07 INFO - 'NO_EM_RESTART': '1', 19:48:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:07 INFO - 'PWD': '/builds/slave/test', 19:48:07 INFO - 'SHELL': '/bin/bash', 19:48:07 INFO - 'SHLVL': '1', 19:48:07 INFO - 'TERM': 'linux', 19:48:07 INFO - 'TMOUT': '86400', 19:48:07 INFO - 'USER': 'cltbld', 19:48:07 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:07 INFO - '_': '/tools/buildbot/bin/python'} 19:48:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:08 INFO - Downloading/unpacking jsonschema 19:48:08 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 19:48:08 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 19:48:08 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 19:48:08 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 19:48:08 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 19:48:08 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 19:48:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 19:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 19:48:09 INFO - Downloading/unpacking functools32 (from jsonschema) 19:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:09 INFO - Downloading functools32-3.2.3-2.tar.gz 19:48:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 19:48:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 19:48:09 INFO - warning: no files found matching '*.txt' 19:48:09 INFO - no previously-included directories found matching 'build' 19:48:09 INFO - no previously-included directories found matching 'dist' 19:48:09 INFO - no previously-included directories found matching '.git*' 19:48:09 INFO - Installing collected packages: jsonschema, functools32 19:48:10 INFO - Running setup.py install for functools32 19:48:10 INFO - warning: no files found matching '*.txt' 19:48:10 INFO - no previously-included directories found matching 'build' 19:48:10 INFO - no previously-included directories found matching 'dist' 19:48:10 INFO - no previously-included directories found matching '.git*' 19:48:10 INFO - Successfully installed jsonschema functools32 19:48:10 INFO - Cleaning up... 19:48:10 INFO - Return code: 0 19:48:10 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 19:48:10 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')]} 19:48:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:48:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:10 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')]} 19:48:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:48:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:48:10 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 0x7f307f114f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11018a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x11cf240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, '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': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', '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 19:48:10 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 19:48:10 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 19:48:10 INFO - Using env: {'DISPLAY': ':0', 19:48:10 INFO - 'HOME': '/home/cltbld', 19:48:10 INFO - 'LANG': 'en_US.UTF-8', 19:48:10 INFO - 'LANGUAGE': 'en_US:en', 19:48:10 INFO - 'LOGNAME': 'cltbld', 19:48:10 INFO - 'MAIL': '/var/mail/cltbld', 19:48:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:10 INFO - 'MOZ_NO_REMOTE': '1', 19:48:10 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:10 INFO - 'NO_EM_RESTART': '1', 19:48:10 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:10 INFO - 'PWD': '/builds/slave/test', 19:48:10 INFO - 'SHELL': '/bin/bash', 19:48:10 INFO - 'SHLVL': '1', 19:48:10 INFO - 'TERM': 'linux', 19:48:10 INFO - 'TMOUT': '86400', 19:48:10 INFO - 'USER': 'cltbld', 19:48:10 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:10 INFO - '_': '/tools/buildbot/bin/python'} 19:48:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:48:10 INFO - Downloading/unpacking flake8 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48: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 19:48:12 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 19:48:12 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 19:48:12 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 19:48:12 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 19:48:12 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpyflakes-1.0.0-py2.py3-none-any.whl 19:48:12 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:48:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:48:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:48:12 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 19:48:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 19:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:48:12 INFO - no previously-included directories found matching 'docs/_build' 19:48:12 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 19:48:12 INFO - Running setup.py install for pep8 19:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 19:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 19:48:12 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 19:48:12 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 19:48:12 INFO - no previously-included directories found matching 'docs/_build' 19:48:12 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 19:48:12 INFO - Successfully installed flake8 mccabe pyflakes pep8 19:48:12 INFO - Cleaning up... 19:48:12 INFO - Return code: 0 19:48:12 INFO - Running post-action listener: _resource_record_post_action 19:48:12 INFO - Running post-action listener: _start_resource_monitoring 19:48:12 INFO - Starting resource monitoring. 19:48:12 INFO - ##### 19:48:12 INFO - ##### Running install step. 19:48:12 INFO - ##### 19:48:12 INFO - Running pre-action listener: _resource_record_pre_action 19:48:12 INFO - Running main action method: install 19:48:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 19:48:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 19:48:13 INFO - Reading from file tmpfile_stdout 19:48:13 INFO - Detecting whether we're running mozinstall >=1.0... 19:48:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 19:48:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 19:48:13 INFO - Reading from file tmpfile_stdout 19:48:13 INFO - Output received: 19:48:13 INFO - Usage: mozinstall [options] installer 19:48:13 INFO - Options: 19:48:13 INFO - -h, --help show this help message and exit 19:48:13 INFO - -d DEST, --destination=DEST 19:48:13 INFO - Directory to install application into. [default: 19:48:13 INFO - "/builds/slave/test"] 19:48:13 INFO - --app=APP Application being installed. [default: firefox] 19:48:13 INFO - mkdir: /builds/slave/test/build/application 19:48:13 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'] 19:48:13 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 19:48:27 INFO - Reading from file tmpfile_stdout 19:48:27 INFO - Output received: 19:48:27 INFO - /builds/slave/test/build/application/firefox/firefox 19:48:27 INFO - Running post-action listener: _resource_record_post_action 19:48:27 INFO - ##### 19:48:27 INFO - ##### Running run-tests step. 19:48:27 INFO - ##### 19:48:27 INFO - Running pre-action listener: _resource_record_pre_action 19:48:27 INFO - Running main action method: run_tests 19:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 19:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 19:48:27 INFO - Python 2.7.3 19:48:27 INFO - Return code: 0 19:48:27 INFO - grabbing minidump binary from tooltool 19:48:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:48:27 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x125e0b0>, '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 0x125efb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x125f440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 19:48:27 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 19:48:27 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 19:48:27 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 19:48:27 INFO - Return code: 0 19:48:27 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 19:48:27 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 19:48:27 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 19:48:27 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 19:48:27 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 19:48:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 19:48:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 19:48:28 INFO - Return code: 0 19:48:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 19:48:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 19:48:28 INFO - Using env: {'DISPLAY': ':0', 19:48:28 INFO - 'HOME': '/home/cltbld', 19:48:28 INFO - 'LANG': 'en_US.UTF-8', 19:48:28 INFO - 'LANGUAGE': 'en_US:en', 19:48:28 INFO - 'LOGNAME': 'cltbld', 19:48:28 INFO - 'MAIL': '/var/mail/cltbld', 19:48:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 19:48:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 19:48:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:48:28 INFO - 'MOZ_NO_REMOTE': '1', 19:48:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 19:48:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:48:28 INFO - 'NO_EM_RESTART': '1', 19:48:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:48:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:48:28 INFO - 'PWD': '/builds/slave/test', 19:48:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 19:48:28 INFO - 'SHELL': '/bin/bash', 19:48:28 INFO - 'SHLVL': '1', 19:48:28 INFO - 'TERM': 'linux', 19:48:28 INFO - 'TMOUT': '86400', 19:48:28 INFO - 'USER': 'cltbld', 19:48:28 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1449529505.270412-1381483002', 19:48:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:48:28 INFO - '_': '/tools/buildbot/bin/python'} 19:48:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 19:48:29 INFO - mozversion INFO | application_buildid: 20151207183223 19:48:29 INFO - mozversion INFO | application_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 19:48:29 INFO - mozversion INFO | application_display_name: Nightly 19:48:29 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 19:48:29 INFO - mozversion INFO | application_name: Firefox 19:48:29 INFO - mozversion INFO | application_remotingname: firefox 19:48:29 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 19:48:29 INFO - mozversion INFO | application_vendor: Mozilla 19:48:29 INFO - mozversion INFO | application_version: 45.0a1 19:48:29 INFO - mozversion INFO | platform_buildid: 20151207183223 19:48:29 INFO - mozversion INFO | platform_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 19:48:29 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 19:48:29 INFO - mozversion INFO | platform_version: 45.0a1 19:48:29 INFO - 2015-12-07 19:48:29,023 DEBUG : using testdate: 1449546509 19:48:29 INFO - 2015-12-07 19:48:29,023 DEBUG : actual date: 1449546509 19:48:29 INFO - 2015-12-07 19:48:29,069 INFO : starting webserver on 'localhost:45909' 19:48:29 INFO - 2015-12-07 19:48:29,070 INFO : Starting test suite talos-linux64-ix-039.e 19:48:29 INFO - 2015-12-07 19:48:29,070 INFO : Starting test dromaeo_css 19:48:29 INFO - 2015-12-07 19:48:29,071 DEBUG : operating with platform_type : linux_ 19:48:29 INFO - 2015-12-07 19:48:29,071 INFO : Initialising browser for dromaeo_css test... 19:48:29 INFO - 2015-12-07 19:48:29,083 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUyVkRu/profile http://localhost:45909/getInfo.html 19:48:33 INFO - 2015-12-07 19:48:33,844 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:48:33 INFO - 2015-12-07 19:48:33,844 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:48:33 INFO - 2015-12-07 19:48:33,844 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 19:48:33 INFO - 2015-12-07 19:48:33,844 DEBUG : BROWSER_OUTPUT: __metrics 19:48:34 INFO - 2015-12-07 19:48:34,010 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] 19:48:34 INFO - 2015-12-07 19:48:34,892 INFO : Browser initialized. 19:48:34 INFO - 2015-12-07 19:48:34,893 INFO : Running cycle 1/1 for dromaeo_css test... 19:48:34 INFO - 2015-12-07 19:48:34,893 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUyVkRu/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:48:46 INFO - 2015-12-07 19:48:46,958 DEBUG : BROWSER_OUTPUT: RSS: Main: 143081472 19:48:46 INFO - 2015-12-07 19:48:46,959 DEBUG : BROWSER_OUTPUT: 19:49:36 INFO - 2015-12-07 19:49:36,607 DEBUG : BROWSER_OUTPUT: 1449546576604 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] 19:51:48 INFO - 2015-12-07 19:51:48,602 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45909/tests/dromaeo/cssquery-ext.html) 19:51:49 INFO - 2015-12-07 19:51:49,780 DEBUG : BROWSER_OUTPUT: RSS: Main: 147562496 19:51:49 INFO - 2015-12-07 19:51:49,780 DEBUG : BROWSER_OUTPUT: 19:54:51 INFO - 2015-12-07 19:54:51,933 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-ext.html (next: http://localhost:45909/tests/dromaeo/cssquery-jquery.html) 19:54:52 INFO - 2015-12-07 19:54:52,522 DEBUG : BROWSER_OUTPUT: RSS: Main: 145440768 19:54:52 INFO - 2015-12-07 19:54:52,522 DEBUG : BROWSER_OUTPUT: 19:57:54 INFO - 2015-12-07 19:57:54,225 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45909/tests/dromaeo/cssquery-mootools.html) 19:57:54 INFO - 2015-12-07 19:57:54,819 DEBUG : BROWSER_OUTPUT: RSS: Main: 144777216 19:57:54 INFO - 2015-12-07 19:57:54,819 DEBUG : BROWSER_OUTPUT: 20:00:56 INFO - 2015-12-07 20:00:56,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45909/tests/dromaeo/cssquery-prototype.html) 20:00:57 INFO - 2015-12-07 20:00:57,189 DEBUG : BROWSER_OUTPUT: RSS: Main: 143998976 20:00:57 INFO - 2015-12-07 20:00:57,190 DEBUG : BROWSER_OUTPUT: 20:03:59 INFO - 2015-12-07 20:03:59,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45909/tests/dromaeo/cssquery-yui.html) 20:04:00 INFO - 2015-12-07 20:04:00,428 DEBUG : BROWSER_OUTPUT: RSS: Main: 143069184 20:04:00 INFO - 2015-12-07 20:04:00,428 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,677 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/dromaeo/cssquery-yui.html (next: http://localhost:45909/tests/dromaeo/cssquery-dojo.html) 20:07:02 INFO - 2015-12-07 20:07:02,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 147394560 20:07:02 INFO - 2015-12-07 20:07:02,928 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,929 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:07:02 INFO - 2015-12-07 20:07:02,929 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:07:02 INFO - 2015-12-07 20:07:02,930 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:07:02 INFO - 2015-12-07 20:07:02,930 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:07:02 INFO - 2015-12-07 20:07:02,933 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.7856376207474;2713.782897368211;2744.6980832108466;2755.6004379364995;2760.4893094777467;4584.151931892602;4772.642051846108;4808.254720518321;4810.567048965592;4813.855584332467;4688.671792974493;4699.2951057341415;4715.858524244278;4752.358431611731;4794.736289504076;4347.739135651863;4418.779061046951;4474.060447306069;4478.507364189953;4501.234790085677;4403.779811009453;4427.88930276744;4436.689431739779;4506.346579745935;4525.275955847065;4200.3699445083175;4290.506591741959;4323.3947247385395;4411.250087485135;4424.11517696462;4418.823247070113;4437.112577484516;4441.400410944513;4445.799939002753;4484.439445069366;4411.228035093878;4416.734995900224;4418.955810441918;4458.732476051415;4460.643148548141;4427.734335939822;4530.456345238559;4616.469106052813;4721.811127554894;4763.333133361332;5132.255822905658;5156.561692256125;5172.069027575035;5175.585953123741;5237.79048838046;4967.081089998362;5178.533931946105;5201.219817027439;5206.297149884755;5211.140161873286;4643.582077612963;4715.7877895494785;4747.596454301389;4747.928781068286;4762.095201911626;5279.445658205833;5307.389650190277;5307.495787900143;5314.256004159421;5339;5106.846794596168;5114.616403769658;5125.692458452505;5131.7177555234075;5134.717590532557;4920.5571498565305;5019.648624596243;5021.899562008813;5023.673461225008;5030.723310217973;4958.330625365529;5009.574186194214;5070.569001634903;5074.949250507521;5117.5905927526455;5052.368453943257;5065.518775716301;5065.949340506548;5071.036503064406;5109.335786347751;4082.530508991504;4161.459010328698;4214.4310518079665;4279.716805365793;4299.419578356944;3619.2942376236906;3684.1342284563107;3694.6674799268194;3713.628637136319;3730.515033045687;4401.273789824707;4449.710768800018;4467.084247729208;4489.6408287336935;4496.505384407713;4870.09903167915;5003.049420610072;5018.924716129261;5183.403908550489;5202.557782588522;4451.109778044404;4467.798949047301;4476.060027394218;4503.729776213372;4523.683342166082;4560.95439045612;4576.633869290449;4587.678862479661;4607.539246075366;4639.976800115978;4655.324977878188;4700.2949557566635;4784.091022705675;4847.660663753503;4866.391701037371;5074.985002999489;5085.211792172219;5094.745262736922;5128.640995130305;5204.479552044765;4843.200871856105;4859.659823812299;4882.9755851221935;4889.584385327287;4925.310456536159;4772.379590653193;4902.068606964665;4987.950120498748;5056.721880296619;5132.743362831919;5107.10625640504;5163.896722065462;5169.7673604687125;5186.818461353985;5215.869603259949;4825.155597770447;4990.6007519397635;5004.799808007639;5009.223570346602;5013.423456302572;4897.069556784199;4918.065567542156;4947.802087916443;4985.4266759323145;5007.84976450707;4802.927956080592;4846.878828029327;4876.24418215163;4876.878078048077;4896.681715688469;4782.545658162469;4846.200376937766;5003.724795136157;5007.47421520735;5041.369828771403;4788.4253889533475;4827.879303017453;4849.102915960559;4852.8544143675745;4895.583875370491 20:07:02 INFO - 2015-12-07 20:07:02,935 DEBUG : BROWSER_OUTPUT: |1;ext.html;523.1759978034596;535.2132365422827;538.927244821949;544.3630951786411;556.9053260945639;35150;35594.28811423773;35641.64358356415;35724.46413303796;35726.46410303841;39770.403443948366;40265.798671006676;40285.19429611406;40442.39336409956;40510.392344114865;8006.91993080069;8185.672573097069;8190.713325033625;8191.221833925797;8209.179082091803;7857.803554911145;7994.440389172761;8026.919730802676;8030.196980301981;8039.477433966774;7925.643346049413;7997.960010199941;8025.478343907627;8048.396370272224;8070.596470176468;7865.921340786605;7950.681972721113;7966.123726390092;7966.6415011324625;7967.800804979864;7905.881411778828;7997.480163789335;8015.7595272141925;8044.115147333789;8055.31529819966;36188.819055904816;36449.453258201145;36543.355549000094;36606;36626.45060324097;2809.2134202423354;2865.025891197003;2887.2926133097317;3348.296857659894;3550.183457804719;27934.860325698446;28133.57799633007;28200.576991345148;28588.428231435253;28738.425231495254;3309.113018170217;3340.799552026862;3453.7755045921936;3464.4630082337276;3506.2461570762407;200769;202665;203329.98335008378;203545;203946;49788;51286.743566282676;52304.47695522996;52458.475415246125;52632.47367526352;61765.38234617686;63087.36912630815;63129.68435157795;63210.68394657997;63453.68273158697;12288.447019883948;12363.876361236273;12365.938170309271;12377.071719621064;12405.689857753629;10349.689509314732;10397.220208484394;10423.5830566778;10437.32157409766;10470.424126672953;18050.18774155166;18485.075746212904;18512.44462666122;18525.629487410446;18547.629047419246;7417.33244008031;7751.961240193876;7758.495697779626;7794.2985131338455;7811.257930496594;847.7329641163014;865.8701194820827;866.7009881590841;900.8288425199322;962;25858.87070564673;26111.477770444486;27103.186904392507;27322.45355092887;27452.588211176848;923.93532452729;978.9118979291756;985.669800616787;1010.1161483701761;1059.6873922192972;14106.294685265695;14398.40828650832;14504.202268875313;14746.115233085835;14805.259737013323;260421;262815;264899;265969;265983;41981.79009104996;42044.579554204065;42145.578544214775;42292.57707422948;42379;1214.9210301330386;1236.771197328497;1242.2918936206277;1272.5609664665676;1273.325137677014;26771.598426024015;26781.001980415276;27074.864625677532;27169;27250;39458;39469.2106157881;39509.20981580295;39834;39857.80071099742;251459;252488;252717;252936;254005;27664.861675692297;30822.383552329276;31080.68919310778;31289.8435507821;31303.530447042856;36171.27657446784;36852.262954741294;36989.26021479609;37248.255034899696;37517.81241093777;31303.217419564695;31566;31584.368312634077;32478;32921;31586.052418426563;31935.201619959687;32046.35907281888;32074.35851283008;32196.35607287888;30107.69892301049;30193.245168870955;30378;30578.541321879744;30772.53841192339;28112.29719257035;28984.275393115342;30567;30671.846640766653;30880.53679194769;21589.13643454244;22074.44813879666;24072.277831665077;24090.63864042076;24723.87638061798 20:07:02 INFO - 2015-12-07 20:07:02,936 DEBUG : BROWSER_OUTPUT: |2;jquery.html;272.93995321029394;273.1886297695843;275.79591102584095;279.8418893325271;286.28571713574627;13825.654358641039;14005;15233.086014839117;15629.84370156298;15665.138417387054;9850.310478266525;10095.596176152963;10117.089461948422;14674.633134171625;16065.357385704558;4504.752238626874;4591.1965406053805;4626.606738427221;4643.257078867382;4655.813767449298;4678.204705200124;4810.9037819243595;4976.129177393959;4977.278294647274;4977.576905962979;4701.553352431513;4865.635077369194;4892.168331383656;4933.777979990909;4946.802127914897;4919.286703428001;4924.655274130831;4936.5063493650705;4939.135651261033;4941.530554597308;4643.88390290242;4728.810847566093;4762.6904251223905;4786.617070634341;4805.8558243252755;11132.888671113347;11213.327200368005;11351.489182986703;18673.346432874783;19324;1723.638036012439;1770.2122555462824;1809.5566586186337;1827.3330234464458;1929.4211736479;8737.650493980233;8942.731718048404;8971.685990990283;11207.495662695199;12659.30373829439;1753.9035353055576;1758.2088060372755;1780.1010489702746;1801.774778152731;1813.1115753280928;53815.19277210845;56169.43830561683;56310.436895630926;56448;56633;9269.490178040138;9347.112024357675;9509.286803489627;9556.092171243721;9600.279979001603;11785.410729463663;11785.646430606925;11799.52801887932;11831.526738930346;11843.526258949545;6969.721211151598;7010.298970103051;7063.399611033017;7130;7149.285071492913;6941.652917354112;6944.4097251734165;6955.6869940852785;6967;6991.09115814951;3713.7586056906757;3793.696504279651;3794.5636251830842;3856.9971807329734;3859.459675645412;1600.7278762610383;1655.5364497940595;1702.9744553831702;1707.0525858148847;1720.2602880761142;863.4258218284896;878.4509681449094;886.8802711633847;923.8060007398387;926.6895589977433;14913.179775112256;14914;15032.774508382383;15290.923545382202;15355.155466449452;838.9916100838914;858.9871151932726;865.16079402979;889.1952782731638;894.7092195036639;9118.726438206864;9127.680531181377;9177.495237761987;9200.631974721071;9278.860817087749;443738;447991;454917;458386;461526;68469.65765171142;71639.64180179065;71862;72293.63853180701;72421.27578724251;978.9706308810747;984.2863923655293;991.2317953585884;992.9602815887428;1027.5735569738624;14071.859281407464;14210.25406362561;14294.857051429353;14381.424743010162;14573.125612463286;33192.502112467846;33295.99999999903;33881.49177762385;34177;34611.653883460844;42928.78535607302;43949;44412.77793611011;46089;47509;8984.513417878266;9076.546172691471;9192.034836342087;9283.860742088738;9298.628054877729;16149.919250404142;16392.180390980164;16561.83438165603;16831.326746929986;16831.41090061842;13483.123596966167;13534.526291579747;13593.52422665202;13727.45090196381;14305;12887.453505579391;13369.66575835612;13371.197728136343;13682.31588420595;13932.233727145105;13765.655858603615;13997.860021399656;14190.432382704576;14203.076800007966;14290;8539.530325832138;8617.526036067826;8630.611622477129;9119.088091190828;9125.361224714206;10452.581896724047;14057;14141.292935352985;14172.563625077591;14238.430462781787 20:07:02 INFO - 2015-12-07 20:07:02,939 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1402.4109873852988;1421.268046955818;1479.4599971010584;1635.8691304695622;1723.870709696773;5798.797042103527;6097.5426842986735;7191.2808719128125;7290.854182916339;7307.780766577004;6606.075149479077;6807.795766127024;6847.212570554375;6848.10974573306;6865.210500792398;2035.2673037706413;2067.131804642054;2067.514134178467;2072.1400618743205;2072.8549001569822;2038.520947577318;2075.4915045813796;2078.5738923520644;2085.906134223956;2097.4336929029155;2026.8074532919422;2037.7758446570865;2057.341650671778;2059.063126277548;2065.411357763038;2058.1664425907456;2076.5431605046865;2081.6357137500954;2082.645950188464;2087.217293514932;2007.7389939307943;2026.432598872318;2029.7158397824317;2032.471557395088;2063.3912995666315;7089.645517724093;7167.605781682006;7172.390346820526;7190.604516751577;7223.530470519452;4051.3112770828734;4073.3075377185655;4092.631663150331;4104.015036391274;4127.504699436057;2622.8426294422206;2667.2798344447083;2702.067786613615;2714.8506832124226;2715.5383584790634;843.9367047471403;852.654674856684;867.5965675960646;869.6477926439802;883.1389395339556;9038.186563209278;9086.727398178065;9089.818203635956;9110.088991100904;9152.313576481723;3614.4578313252696;3635.4728564358547;3653.50677658518;3656.1225305926387;3668.0463079599494;7802.687892484237;7838.098618658813;7844.176361482077;7857.646405911748;7895.526268423913;4045.5145382554283;4056.51321841375;4060.2285565742413;4064.451299074646;4085.346344584852;3125.687431256856;3213.53403756454;3498.8425520851624;3720.2187540616774;3730.3658378075793;3275.3121844412462;3374.713149382281;3374.797512149279;3407.744419168572;3418.9829050854587;1056.1181413519796;1058.9894101059044;1068.5779117248644;1068.9625863094755;1074.9247552671395;1106.4080716816625;1115.2472081345059;1121.315997241682;1128.6839684888243;1146.564305563897;6505.316941721146;6512.185976752906;6513.967430162819;6533.444657204191;6567;1076.4832880217539;1119.6081371519904;1137.4142316706902;1141.3836528274805;1152.2107356460851;4884.918798073561;5046.44489106198;5083.161278389024;5083.415407228216;5084.51697088776;8489.660413583511;8682.262007729287;8741.125887411335;8772.517511536927;8792.824143517222;8438.156184381636;8590.742277731679;8613.78465538354;8641.395102342902;8705.608247628745;6733.494987875929;6751;6806.285340039323;6810.5913645181445;6850.9314906850295;6190.659513726789;6292.276388215414;6310.558260921875;6311.90532142009;6312.936870631235;7629.0845098588525;7711.228877112244;7724.304812566896;7753.612319383896;7831.334336581454;7783.494072885244;7959.880601791094;7994.760157195294;8001.479903806234;8009.679612815422;4934.950650493449;5023.824166154313;5841.707914604168;5906.881862362815;5909.438603332676;6241.126242325987;6427.292997770335;6444.8388790280615;6501.642409667514;6504.804855854332;6111.755529778937;6131.877362452815;6139.3553676863285;6243.032329988859;6318.873622527615;6117.449429551361;6194.256689197145;6241.750329986749;6317.305096439296;6364.109024736448;6448.355164483702;6480.384363485461;6481.967590162019;6483.870322593428;6486.351364863476;5849.093390524476;5850.444207800252;5906.202662640489;5906.70466476683;5918.852028699144;5886.499647529837;5930.970345148246;5937.495312898279;5964.761409543569;5976.223090998316 20:07:02 INFO - 2015-12-07 20:07:02,941 DEBUG : BROWSER_OUTPUT: |4;prototype.html;255.3539544951274;256.8946731839946;256.95246379419797;262.96844378674564;263.67699568029167;5518.724063796809;5588.7205639718;5600.019996500611;5610.13042978338;5756.654600723949;5536.280283563141;5563.638363506369;5612.045952188128;5624.493795558399;5629.577781666371;4062.6343629073453;4139.689523285766;4143.917121657565;4144.875653730378;4158.521769996459;4127.29835927893;4154.169166166764;4166.6666666666615;4185.309423945046;4204.444355588436;4145.316022856225;4149.439825623547;4150.128473020669;4150.896227594304;4156.459660244164;4132.834686612532;4150.149219410029;4151.481064866892;4152.37714342848;4156.127213285214;3407.812570308632;3408.6761757632985;3476.600190978045;3487.7209823214334;3535.9646403535894;5305.204219367087;5323.254744335796;5356.491133342326;5362.517373436371;5370.8925821483745;4744.667873248874;4745.145873742725;4756.025014871943;4757.357756702835;4757.976210118927;5829;5835.124731290298;5839.153322768218;5848.327442344143;5857.297124345106;3706.796126213057;3821.159344944108;3842.077901303667;3845.2309538092213;3847.7883716395586;6145.446909778141;6188.907166392508;6210.968945155245;6220.129181914535;6227.501799856001;3866.2267546490816;3876.6898648108086;3882.6699730523223;3884.3396622574232;3901.5903330150495;3940.3498422760495;3943;3943.211357728466;3948.269570129535;3952.3478626026385;4581.221192397234;4681.110588988081;4686.437627484655;4692.296155576691;4707.6233901287815;5893.5874488785375;5912.73392697321;5915.852103697442;5915.881682366328;5919.260092488439;1386.0090035624376;1390.6731917999261;1401.2643362234908;1404.8243969503812;1408.3732738931078;869.5347988825948;880.7621942075604;890.950997695133;897.7576054465388;898.6899519665704;5141.614378921596;5177.948220517822;5191.870203244949;5192.792288308426;5216.66091704038;6168.0439531872635;6170.352113028068;6171.506279497629;6171.876562468726;6175.907361389583;5173.560247379015;5183.663061900965;5188.377394712583;5190.948090519122;5192;3241.497567876983;3322.0200040987966;3326.634070252319;3328.6172090209934;3332.183615014337;5682.914756278659;5791.826245212566;5803.448672376117;5810.593258471867;5831.979403604352;6284.560080794392;6286.277078136073;6309.801137783898;6325.05124231369;6392.456641185551;5849.1226316052935;5850.64896106235;5870.618409803349;5871.295444546597;5873.177755114202;6033.366496517802;6145;6191.349908259568;6192.628442293477;6199.752009919553;6028.367021462684;6068.969655151696;6096.847578810565;6107.877842443215;6110.633361998294;5787.305523337226;5853.2390789198835;5857.677827719346;5861.648301101947;5870.119482077723;3929.115948911472;3979.960200397959;4021.738586991836;4026.979865100656;4031.072853243829;6092.45167934888;6094.421030002142;6108.419700128481;6109.725062372115;6124.38756124384;5894.410558944071;5918.733656985532;5920.555958303058;5927;5935.0207215808905;5830.416958304136;5887.852803679943;5907.4683278505145;5916.230889984275;5933.050711886078;5605.467480589337;5731.8853622928145;5742;5774.595778295479;5782.566307527037;5914.3198532167635;5917.674527900835;5927.199828023334;5929.318128415288;5942.554308426799;5748.166515855261;5771.163181338598;5787.160861674949;5788;5800.39095894925 20:07:02 INFO - 2015-12-07 20:07:02,942 DEBUG : BROWSER_OUTPUT: |5;yui.html;673.464595646461;682.2870100744722;693.8889777635576;738.8005238585586;742.9554226746395;10760.946195269022;10877.401742904138;11015.779684406318;11023.944880275587;11025.338479691223;11331.716707082307;11797.823032654516;11799.764004719922;11829.290242585452;11844.289342639448;776.8252143267762;781.1056340490164;782.0615261685971;804.859149648812;806.9354451643854;785.1167436633787;785.8271180340345;790.6639678136769;790.9802254943614;791.5448617045222;791.1337085890968;820.4666966471782;829.4567058576642;830.3440282177073;831.476170012894;818.5907046476761;823.3084209264217;824.3940703582862;825.2613910550084;826.0294154368593;607.4441885674603;610.4993904997904;610.5359926455881;610.7160170520684;610.9816705498843;12001.699957501045;12185.086118541145;12188.634340969786;12189.878101218963;12201.38993050344;10816.783664326747;11247.55009799607;11392.772144557146;11476.426178691032;11657.533698652043;9083.954580227057;9291;9350.205232555241;9436.716898493056;9465.479398633073;3251.983740081308;3264.363449127421;3305.983470082658;3308.4375656138513;3340.048086295418;40335.19329613421;40436.393454098215;40526.594734052574;40705.796471018046;40719;8046.517208967481;8090.069641991128;8161.183881611792;8170.223828736261;8306.335493160654;14915.328810203568;14994.62513437151;15163;15222.238888055554;15294.923525382303;6230.06549017651;6292.968535157295;6351.237851457762;6373.776917807854;6458.095866578588;3595.173110184672;3614.9096272593397;3629.891103266906;3655.597884232732;3681.466187402865;2595.0398352609654;2623.6851577810785;2627.3037645024083;2628.4217472156097;2634.5257853586154;467.1544504446962;471.61327711276425;481.1988039913505;483.079733108429;486.8125771577968;551.181495479213;552.8479668091308;573.3549756523911;591.2550186764621;616.1681729664916;7876.448648594658;7984.560849153352;8087.393445491612;8132.878006829902;8197.139300373376;501.3707796715099;568.8622754491018;582;613.6992873491956;625.0624063904144;3579.7494175407473;3609.530761001053;3639.70882329413;3794.1083845296334;3858.3826587745825;47117.76441117841;47730.5226947733;48053;48473.75763121162;48966.51033489619;43186.35220471695;43463.34804977928;44242.557574423845;44300.556994430284;44439.33340999888;38992.22015559729;39046.609533904295;39380;39521;39996.20007599832;7341.192468828532;7385.519941204019;7431.36833369148;7561.621918904143;7677.9232207677205;30559.54160687636;30694.84652576723;30860.382792344477;30869.382612347177;31030.22424439407;35685.82157089198;35964;38799.22401552009;39082.41376379413;39203.41194882136;8936.28509719208;9002.099790020946;9051.366404351633;9159.679411220843;9241.86137207929;9958.800823983625;10058.748531286483;10214.131798796889;10214.642487512901;10263.384196948207;9951.751206219902;9981.151602113901;10059.899401005896;10068.24488163376;10180.371140617763;8909.1536304051;9058;9108.954455227946;9164.633414663338;9450.385724927857;8757.649694012169;9159.679411220843;9395.107464790834;9428.481433521221;9469.289803264921;8070.2333278338465;8141.22658347456;8250.711225107092;8322;8464.44981076228;7926.801829954297;8123.228293312126;8321.500709957421;8704.956475217583;9028.503432311023 20:07:02 INFO - 2015-12-07 20:07:02,942 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:07:02 INFO - 2015-12-07 20:07:02,942 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:07:02 INFO - 2015-12-07 20:07:02,942 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,327 20:07:02 INFO - 2015-12-07 20:07:02,942 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: __startTimestamp1449547622929__endTimestamp 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,943 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4712.32 Median:4825.16 stddev:493.62 (10.2%) stddev-sans-first:468.57 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: Values: 2675.8 2713.8 2744.7 2755.6 2760.5 4584.2 4772.6 4808.3 4810.6 4813.9 4688.7 4699.3 4715.9 4752.4 4794.7 4347.7 4418.8 4474.1 4478.5 4501.2 4403.8 4427.9 4436.7 4506.3 4525.3 4200.4 4290.5 4323.4 4411.3 4424.1 4418.8 4437.1 4441.4 4445.8 4484.4 4411.2 4416.7 4419.0 4458.7 4460.6 4427.7 4530.5 4616.5 4721.8 4763.3 5132.3 5156.6 5172.1 5175.6 5237.8 4967.1 5178.5 5201.2 5206.3 5211.1 4643.6 4715.8 4747.6 4747.9 4762.1 5279.4 5307.4 5307.5 5314.3 5339.0 5106.8 5114.6 5125.7 5131.7 5134.7 4920.6 5019.6 5021.9 5023.7 5030.7 4958.3 5009.6 5070.6 5074.9 5117.6 5052.4 5065.5 5065.9 5071.0 5109.3 4082.5 4161.5 4214.4 4279.7 4299.4 3619.3 3684.1 3694.7 3713.6 3730.5 4401.3 4449.7 4467.1 4489.6 4496.5 4870.1 5003.0 5018.9 5183.4 5202.6 4451.1 4467.8 4476.1 4503.7 4523.7 4561.0 4576.6 4587.7 4607.5 4640.0 4655.3 4700.3 4784.1 4847.7 4866.4 5075.0 5085.2 5094.7 5128.6 5204.5 4843.2 4859.7 4883.0 4889.6 4925.3 4772.4 4902.1 4988.0 5056.7 5132.7 5107.1 5163.9 5169.8 5186.8 5215.9 4825.2 4990.6 5004.8 5009.2 5013.4 4897.1 4918.1 4947.8 4985.4 5007.8 4802.9 4846.9 4876.2 4876.9 4896.7 4782.5 4846.2 5003.7 5007.5 5041.4 4788.4 4827.9 4849.1 4852.9 4895.6 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39972.13 Median:3324.96 stddev:62885.29 (1891.3%) stddev-sans-first:62991.94 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: Values: 523.2 535.2 538.9 544.4 556.9 35150.0 35594.3 35641.6 35724.5 35726.5 39770.4 40265.8 40285.2 40442.4 40510.4 8006.9 8185.7 8190.7 8191.2 8209.2 7857.8 7994.4 8026.9 8030.2 8039.5 7925.6 7998.0 8025.5 8048.4 8070.6 7865.9 7950.7 7966.1 7966.6 7967.8 7905.9 7997.5 8015.8 8044.1 8055.3 36188.8 36449.5 36543.4 36606.0 36626.5 2809.2 2865.0 2887.3 3348.3 3550.2 27934.9 28133.6 28200.6 28588.4 28738.4 3309.1 3340.8 3453.8 3464.5 3506.2 200769.0 202665.0 203330.0 203545.0 203946.0 49788.0 51286.7 52304.5 52458.5 52632.5 61765.4 63087.4 63129.7 63210.7 63453.7 12288.4 12363.9 12365.9 12377.1 12405.7 10349.7 10397.2 10423.6 10437.3 10470.4 18050.2 18485.1 18512.4 18525.6 18547.6 7417.3 7752.0 7758.5 7794.3 7811.3 847.7 865.9 866.7 900.8 962.0 25858.9 26111.5 27103.2 27322.5 27452.6 923.9 978.9 985.7 1010.1 1059.7 14106.3 14398.4 14504.2 14746.1 14805.3 260421.0 262815.0 264899.0 265969.0 265983.0 41981.8 42044.6 42145.6 42292.6 42379.0 1214.9 1236.8 1242.3 1272.6 1273.3 26771.6 26781.0 27074.9 27169.0 27250.0 39458.0 39469.2 39509.2 39834.0 39857.8 251459.0 252488.0 252717.0 252936.0 254005.0 27664.9 30822.4 31080.7 31289.8 31303.5 36171.3 36852.3 36989.3 37248.3 37517.8 31303.2 31566.0 31584.4 32478.0 32921.0 31586.1 31935.2 32046.4 32074.4 32196.4 30107.7 30193.2 30378.0 30578.5 30772.5 28112.3 28984.3 30567.0 30671.8 30880.5 21589.1 22074.4 24072.3 24090.6 24723.9 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25278.87 Median:246201.89 stddev:74140.94 (30.1%) stddev-sans-first:74325.14 20:07:02 INFO - 2015-12-07 20:07:02,944 DEBUG : BROWSER_OUTPUT: Values: 272.9 273.2 275.8 279.8 286.3 13825.7 14005.0 15233.1 15629.8 15665.1 9850.3 10095.6 10117.1 14674.6 16065.4 4504.8 4591.2 4626.6 4643.3 4655.8 4678.2 4810.9 4976.1 4977.3 4977.6 4701.6 4865.6 4892.2 4933.8 4946.8 4919.3 4924.7 4936.5 4939.1 4941.5 4643.9 4728.8 4762.7 4786.6 4805.9 11132.9 11213.3 11351.5 18673.3 19324.0 1723.6 1770.2 1809.6 1827.3 1929.4 8737.7 8942.7 8971.7 11207.5 12659.3 1753.9 1758.2 1780.1 1801.8 1813.1 53815.2 56169.4 56310.4 56448.0 56633.0 9269.5 9347.1 9509.3 9556.1 9600.3 11785.4 11785.6 11799.5 11831.5 11843.5 6969.7 7010.3 7063.4 7130.0 7149.3 6941.7 6944.4 6955.7 6967.0 6991.1 3713.8 3793.7 3794.6 3857.0 3859.5 1600.7 1655.5 1703.0 1707.1 1720.3 863.4 878.5 886.9 923.8 926.7 14913.2 14914.0 15032.8 15290.9 15355.2 839.0 859.0 865.2 889.2 894.7 9118.7 9127.7 9177.5 9200.6 9278.9 443738.0 447991.0 454917.0 458386.0 461526.0 68469.7 71639.6 71862.0 72293.6 72421.3 979.0 984.3 991.2 993.0 1027.6 14071.9 14210.3 14294.9 14381.4 14573.1 33192.5 33296.0 33881.5 34177.0 34611.7 42928.8 43949.0 44412.8 46089.0 47509.0 8984.5 9076.5 9192.0 9283.9 9298.6 16149.9 16392.2 16561.8 16831.3 16831.4 13483.1 13534.5 13593.5 13727.5 14305.0 12887.5 13369.7 13371.2 13682.3 13932.2 13765.7 13997.9 14190.4 14203.1 14290.0 8539.5 8617.5 8630.6 9119.1 9125.4 10452.6 14057.0 14141.3 14172.6 14238.4 20:07:02 INFO - 2015-12-07 20:07:02,945 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,945 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4868.24 Median:5914.15 stddev:2517.43 (42.6%) stddev-sans-first:2511.01 20:07:02 INFO - 2015-12-07 20:07:02,946 DEBUG : BROWSER_OUTPUT: Values: 1402.4 1421.3 1479.5 1635.9 1723.9 5798.8 6097.5 7191.3 7290.9 7307.8 6606.1 6807.8 6847.2 6848.1 6865.2 2035.3 2067.1 2067.5 2072.1 2072.9 2038.5 2075.5 2078.6 2085.9 2097.4 2026.8 2037.8 2057.3 2059.1 2065.4 2058.2 2076.5 2081.6 2082.6 2087.2 2007.7 2026.4 2029.7 2032.5 2063.4 7089.6 7167.6 7172.4 7190.6 7223.5 4051.3 4073.3 4092.6 4104.0 4127.5 2622.8 2667.3 2702.1 2714.9 2715.5 843.9 852.7 867.6 869.6 883.1 9038.2 9086.7 9089.8 9110.1 9152.3 3614.5 3635.5 3653.5 3656.1 3668.0 7802.7 7838.1 7844.2 7857.6 7895.5 4045.5 4056.5 4060.2 4064.5 4085.3 3125.7 3213.5 3498.8 3720.2 3730.4 3275.3 3374.7 3374.8 3407.7 3419.0 1056.1 1059.0 1068.6 1069.0 1074.9 1106.4 1115.2 1121.3 1128.7 1146.6 6505.3 6512.2 6514.0 6533.4 6567.0 1076.5 1119.6 1137.4 1141.4 1152.2 4884.9 5046.4 5083.2 5083.4 5084.5 8489.7 8682.3 8741.1 8772.5 8792.8 8438.2 8590.7 8613.8 8641.4 8705.6 6733.5 6751.0 6806.3 6810.6 6850.9 6190.7 6292.3 6310.6 6311.9 6312.9 7629.1 7711.2 7724.3 7753.6 7831.3 7783.5 7959.9 7994.8 8001.5 8009.7 4935.0 5023.8 5841.7 5906.9 5909.4 6241.1 6427.3 6444.8 6501.6 6504.8 6111.8 6131.9 6139.4 6243.0 6318.9 6117.4 6194.3 6241.8 6317.3 6364.1 6448.4 6480.4 6482.0 6483.9 6486.4 5849.1 5850.4 5906.2 5906.7 5918.9 5886.5 5931.0 5937.5 5964.8 5976.2 20:07:02 INFO - 2015-12-07 20:07:02,946 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,946 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4817.23 Median:5607.80 stddev:1501.40 (26.8%) stddev-sans-first:1466.04 20:07:02 INFO - 2015-12-07 20:07:02,946 DEBUG : BROWSER_OUTPUT: Values: 255.4 256.9 257.0 263.0 263.7 5518.7 5588.7 5600.0 5610.1 5756.7 5536.3 5563.6 5612.0 5624.5 5629.6 4062.6 4139.7 4143.9 4144.9 4158.5 4127.3 4154.2 4166.7 4185.3 4204.4 4145.3 4149.4 4150.1 4150.9 4156.5 4132.8 4150.1 4151.5 4152.4 4156.1 3407.8 3408.7 3476.6 3487.7 3536.0 5305.2 5323.3 5356.5 5362.5 5370.9 4744.7 4745.1 4756.0 4757.4 4758.0 5829.0 5835.1 5839.2 5848.3 5857.3 3706.8 3821.2 3842.1 3845.2 3847.8 6145.4 6188.9 6211.0 6220.1 6227.5 3866.2 3876.7 3882.7 3884.3 3901.6 3940.3 3943.0 3943.2 3948.3 3952.3 4581.2 4681.1 4686.4 4692.3 4707.6 5893.6 5912.7 5915.9 5915.9 5919.3 1386.0 1390.7 1401.3 1404.8 1408.4 869.5 880.8 891.0 897.8 898.7 5141.6 5177.9 5191.9 5192.8 5216.7 6168.0 6170.4 6171.5 6171.9 6175.9 5173.6 5183.7 5188.4 5190.9 5192.0 3241.5 3322.0 3326.6 3328.6 3332.2 5682.9 5791.8 5803.4 5810.6 5832.0 6284.6 6286.3 6309.8 6325.1 6392.5 5849.1 5850.6 5870.6 5871.3 5873.2 6033.4 6145.0 6191.3 6192.6 6199.8 6028.4 6069.0 6096.8 6107.9 6110.6 5787.3 5853.2 5857.7 5861.6 5870.1 3929.1 3980.0 4021.7 4027.0 4031.1 6092.5 6094.4 6108.4 6109.7 6124.4 5894.4 5918.7 5920.6 5927.0 5935.0 5830.4 5887.9 5907.5 5916.2 5933.1 5605.5 5731.9 5742.0 5774.6 5782.6 5914.3 5917.7 5927.2 5929.3 5942.6 5748.2 5771.2 5787.2 5788.0 5800.4 20:07:02 INFO - 2015-12-07 20:07:02,947 DEBUG : BROWSER_OUTPUT: 20:07:02 INFO - 2015-12-07 20:07:02,947 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11800.66 Median:571.11 stddev:13493.92 (2362.8%) stddev-sans-first:13505.90 20:07:02 INFO - 2015-12-07 20:07:02,947 DEBUG : BROWSER_OUTPUT: Values: 673.5 682.3 693.9 738.8 743.0 10760.9 10877.4 11015.8 11023.9 11025.3 11331.7 11797.8 11799.8 11829.3 11844.3 776.8 781.1 782.1 804.9 806.9 785.1 785.8 790.7 791.0 791.5 791.1 820.5 829.5 830.3 831.5 818.6 823.3 824.4 825.3 826.0 607.4 610.5 610.5 610.7 611.0 12001.7 12185.1 12188.6 12189.9 12201.4 10816.8 11247.6 11392.8 11476.4 11657.5 9084.0 9291.0 9350.2 9436.7 9465.5 3252.0 3264.4 3306.0 3308.4 3340.0 40335.2 40436.4 40526.6 40705.8 40719.0 8046.5 8090.1 8161.2 8170.2 8306.3 14915.3 14994.6 15163.0 15222.2 15294.9 6230.1 6293.0 6351.2 6373.8 6458.1 3595.2 3614.9 3629.9 3655.6 3681.5 2595.0 2623.7 2627.3 2628.4 2634.5 467.2 471.6 481.2 483.1 486.8 551.2 552.8 573.4 591.3 616.2 7876.4 7984.6 8087.4 8132.9 8197.1 501.4 568.9 582.0 613.7 625.1 3579.7 3609.5 3639.7 3794.1 3858.4 47117.8 47730.5 48053.0 48473.8 48966.5 43186.4 43463.3 44242.6 44300.6 44439.3 38992.2 39046.6 39380.0 39521.0 39996.2 7341.2 7385.5 7431.4 7561.6 7677.9 30559.5 30694.8 30860.4 30869.4 31030.2 35685.8 35964.0 38799.2 39082.4 39203.4 8936.3 9002.1 9051.4 9159.7 9241.9 9958.8 10058.7 10214.1 10214.6 10263.4 9951.8 9981.2 10059.9 10068.2 10180.4 8909.2 9058.0 9109.0 9164.6 9450.4 8757.6 9159.7 9395.1 9428.5 9469.3 8070.2 8141.2 8250.7 8322.0 8464.4 7926.8 8123.2 8321.5 8705.0 9028.5 20:07:02 INFO - 2015-12-07 20:07:02,947 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:07:02 INFO - 2015-12-07 20:07:02,947 DEBUG : BROWSER_OUTPUT: 20:07:03 INFO - 2015-12-07 20:07:03,664 INFO : Browser exited with error code: 0 20:07:03 INFO - 2015-12-07 20:07:03,681 INFO : Completed test dromaeo_css (00:18:34) 20:07:03 INFO - 2015-12-07 20:07:03,681 INFO : Starting test kraken 20:07:03 INFO - 2015-12-07 20:07:03,681 DEBUG : operating with platform_type : linux_ 20:07:03 INFO - 2015-12-07 20:07:03,681 INFO : Initialising browser for kraken test... 20:07:03 INFO - 2015-12-07 20:07:03,687 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTEH9j/profile http://localhost:45909/getInfo.html 20:07:08 INFO - 2015-12-07 20:07:08,625 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:07:08 INFO - 2015-12-07 20:07:08,625 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:07:08 INFO - 2015-12-07 20:07:08,626 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:07:08 INFO - 2015-12-07 20:07:08,626 DEBUG : BROWSER_OUTPUT: __metrics 20:07:08 INFO - 2015-12-07 20:07:08,763 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] 20:07:09 INFO - 2015-12-07 20:07:09,740 INFO : Browser initialized. 20:07:09 INFO - 2015-12-07 20:07:09,741 INFO : Running cycle 1/1 for kraken test... 20:07:09 INFO - 2015-12-07 20:07:09,741 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpJTEH9j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:07:21 INFO - 2015-12-07 20:07:21,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 143060992 20:07:21 INFO - 2015-12-07 20:07:21,758 DEBUG : BROWSER_OUTPUT: 20:07:24 INFO - 2015-12-07 20:07:24,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45909/tests/kraken/driver.html?testName=audio-beat-detection) 20:07:24 INFO - 2015-12-07 20:07:24,959 DEBUG : BROWSER_OUTPUT: RSS: Main: 143892480 20:07:24 INFO - 2015-12-07 20:07:24,960 DEBUG : BROWSER_OUTPUT: 20:07:27 INFO - 2015-12-07 20:07:27,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45909/tests/kraken/driver.html?testName=audio-dft) 20:07:28 INFO - 2015-12-07 20:07:28,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 144375808 20:07:28 INFO - 2015-12-07 20:07:28,288 DEBUG : BROWSER_OUTPUT: 20:07:31 INFO - 2015-12-07 20:07:31,200 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45909/tests/kraken/driver.html?testName=audio-fft) 20:07:31 INFO - 2015-12-07 20:07:31,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 138952704 20:07:31 INFO - 2015-12-07 20:07:31,781 DEBUG : BROWSER_OUTPUT: 20:07:33 INFO - 2015-12-07 20:07:33,840 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45909/tests/kraken/driver.html?testName=audio-oscillator) 20:07:34 INFO - 2015-12-07 20:07:34,434 DEBUG : BROWSER_OUTPUT: RSS: Main: 138702848 20:07:34 INFO - 2015-12-07 20:07:34,434 DEBUG : BROWSER_OUTPUT: 20:07:36 INFO - 2015-12-07 20:07:36,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45909/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:07:37 INFO - 2015-12-07 20:07:37,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 140148736 20:07:37 INFO - 2015-12-07 20:07:37,267 DEBUG : BROWSER_OUTPUT: 20:07:40 INFO - 2015-12-07 20:07:40,360 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45909/tests/kraken/driver.html?testName=imaging-darkroom) 20:07:40 INFO - 2015-12-07 20:07:40,961 DEBUG : BROWSER_OUTPUT: RSS: Main: 139395072 20:07:40 INFO - 2015-12-07 20:07:40,961 DEBUG : BROWSER_OUTPUT: 20:07:44 INFO - 2015-12-07 20:07:44,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45909/tests/kraken/driver.html?testName=imaging-desaturate) 20:07:45 INFO - 2015-12-07 20:07:45,016 DEBUG : BROWSER_OUTPUT: RSS: Main: 137367552 20:07:45 INFO - 2015-12-07 20:07:45,016 DEBUG : BROWSER_OUTPUT: 20:07:47 INFO - 2015-12-07 20:07:47,961 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45909/tests/kraken/driver.html?testName=json-parse-financial) 20:07:48 INFO - 2015-12-07 20:07:48,555 DEBUG : BROWSER_OUTPUT: RSS: Main: 137011200 20:07:48 INFO - 2015-12-07 20:07:48,555 DEBUG : BROWSER_OUTPUT: 20:07:50 INFO - 2015-12-07 20:07:50,345 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45909/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:07:50 INFO - 2015-12-07 20:07:50,946 DEBUG : BROWSER_OUTPUT: RSS: Main: 140234752 20:07:50 INFO - 2015-12-07 20:07:50,946 DEBUG : BROWSER_OUTPUT: 20:07:52 INFO - 2015-12-07 20:07:52,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:07:53 INFO - 2015-12-07 20:07:53,488 DEBUG : BROWSER_OUTPUT: RSS: Main: 140578816 20:07:53 INFO - 2015-12-07 20:07:53,488 DEBUG : BROWSER_OUTPUT: 20:07:55 INFO - 2015-12-07 20:07:55,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:07:56 INFO - 2015-12-07 20:07:56,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 140881920 20:07:56 INFO - 2015-12-07 20:07:56,300 DEBUG : BROWSER_OUTPUT: 20:07:58 INFO - 2015-12-07 20:07:58,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:07:59 INFO - 2015-12-07 20:07:59,481 DEBUG : BROWSER_OUTPUT: RSS: Main: 138997760 20:07:59 INFO - 2015-12-07 20:07:59,482 DEBUG : BROWSER_OUTPUT: 20:08:02 INFO - 2015-12-07 20:08:02,118 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:08:02 INFO - 2015-12-07 20:08:02,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 141160448 20:08:02 INFO - 2015-12-07 20:08:02,711 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,491 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45909/tests/kraken/driver.html?testName=ai-astar) 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: RSS: Main: 140582912 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:08:04 INFO - 2015-12-07 20:08:04,749 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;107;114;114;117;126;114;115;114;115 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;162;131;155;168;132;152;157;133;166;141 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;161;162;163;165;168;163;165;166 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;74;72;75;74;131;79;79;73;73 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;129;95;95;94;133;94;94;128 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;110;109;110;109 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;147;150;148;150;148;148;148;148 20:08:04 INFO - 2015-12-07 20:08:04,750 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;97;96;97;96;96;97;96;96 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;76;76;74;75;75;76;76;77;77;74 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;70;68;68;68;69;68;68;68;69 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;93;85;90;95;85;84;87;96 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;130;130;125;120;121;134;122;131;127;126 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;149;157;151;148;150;149;154;154;138 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;72;71;71;73;73;69;69;68;68;72 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:08:04 INFO - 2015-12-07 20:08:04,751 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:08:04 INFO - 2015-12-07 20:08:04,752 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,802 20:08:04 INFO - 2015-12-07 20:08:04,752 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:08:04 INFO - 2015-12-07 20:08:04,752 DEBUG : BROWSER_OUTPUT: __startTimestamp1449547684743__endTimestamp 20:08:04 INFO - 2015-12-07 20:08:04,752 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,753 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:08:04 INFO - 2015-12-07 20:08:04,753 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:08:04 INFO - 2015-12-07 20:08:04,753 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,753 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.00 Median:114.50 stddev:4.64 (4.1%) stddev-sans-first:4.91 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: Values: 114.0 107.0 114.0 114.0 117.0 126.0 114.0 115.0 114.0 115.0 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.70 Median:156.00 stddev:14.36 (9.2%) stddev-sans-first:14.53 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: Values: 162.0 131.0 155.0 168.0 132.0 152.0 157.0 133.0 166.0 141.0 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.00 Median:164.50 stddev:2.05 (1.2%) stddev-sans-first:2.15 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 161.0 162.0 163.0 165.0 168.0 163.0 165.0 166.0 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,754 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:74.00 stddev:17.94 (24.2%) stddev-sans-first:18.88 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 72.0 75.0 74.0 131.0 79.0 79.0 73.0 73.0 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:94.00 stddev:17.23 (18.3%) stddev-sans-first:17.89 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 129.0 95.0 95.0 94.0 133.0 94.0 94.0 128.0 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.03 (0.7%) stddev-sans-first:1.09 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 147.0 150.0 148.0 150.0 148.0 148.0 148.0 148.0 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.00 stddev:0.48 (0.5%) stddev-sans-first:0.50 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 97.0 96.0 97.0 96.0 96.0 97.0 96.0 96.0 20:08:04 INFO - 2015-12-07 20:08:04,755 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:75.60 Median:76.00 stddev:1.07 (1.4%) stddev-sans-first:1.13 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: Values: 76.0 76.0 74.0 75.0 75.0 76.0 76.0 77.0 77.0 74.0 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.00 stddev:0.70 (1.0%) stddev-sans-first:0.73 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 69.0 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:88.20 Median:88.50 stddev:4.92 (5.6%) stddev-sans-first:4.84 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 93.0 85.0 90.0 95.0 85.0 84.0 87.0 96.0 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,756 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.60 Median:128.50 stddev:4.67 (3.6%) stddev-sans-first:4.79 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: Values: 130.0 130.0 125.0 120.0 121.0 134.0 122.0 131.0 127.0 126.0 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:150.50 stddev:6.34 (4.2%) stddev-sans-first:5.39 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: Values: 138.0 149.0 157.0 151.0 148.0 150.0 149.0 154.0 154.0 138.0 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.60 Median:71.50 stddev:1.96 (2.7%) stddev-sans-first:2.01 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 73.0 73.0 69.0 69.0 68.0 68.0 72.0 20:08:04 INFO - 2015-12-07 20:08:04,757 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:08:04 INFO - 2015-12-07 20:08:04,758 DEBUG : BROWSER_OUTPUT: 20:08:05 INFO - 2015-12-07 20:08:05,688 INFO : Browser exited with error code: 0 20:08:05 INFO - 2015-12-07 20:08:05,742 INFO : Completed test kraken (00:01:02) 20:08:05 INFO - 2015-12-07 20:08:05,742 INFO : Starting test v8_7 20:08:05 INFO - 2015-12-07 20:08:05,742 DEBUG : operating with platform_type : linux_ 20:08:05 INFO - 2015-12-07 20:08:05,742 INFO : Initialising browser for v8_7 test... 20:08:05 INFO - 2015-12-07 20:08:05,748 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzeA2j/profile http://localhost:45909/getInfo.html 20:08:10 INFO - 2015-12-07 20:08:10,615 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:08:10 INFO - 2015-12-07 20:08:10,615 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:08:10 INFO - 2015-12-07 20:08:10,615 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:08:10 INFO - 2015-12-07 20:08:10,615 DEBUG : BROWSER_OUTPUT: __metrics 20:08:10 INFO - 2015-12-07 20:08:10,752 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] 20:08:10 INFO - 2015-12-07 20:08:10,869 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://gre/modules/IndexedDBHelper.jsm, line 138: UnknownError: The operation failed for reasons unrelated to the database itself and not covered by any other error code. 20:08:11 INFO - 2015-12-07 20:08:11,708 INFO : Browser initialized. 20:08:11 INFO - 2015-12-07 20:08:11,709 INFO : Running cycle 1/1 for v8_7 test... 20:08:11 INFO - 2015-12-07 20:08:11,709 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCzeA2j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:08:23 INFO - 2015-12-07 20:08:23,740 DEBUG : BROWSER_OUTPUT: RSS: Main: 143085568 20:08:23 INFO - 2015-12-07 20:08:23,740 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45909/tests/v8_7/run.html (next: http://localhost:45909/tests/v8_7/run.html) 20:08:45 INFO - 2015-12-07 20:08:45,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 138387456 20:08:45 INFO - 2015-12-07 20:08:45,510 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,511 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:08:45 INFO - 2015-12-07 20:08:45,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:08:45 INFO - 2015-12-07 20:08:45,511 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:08:45 INFO - 2015-12-07 20:08:45,511 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:08:45 INFO - 2015-12-07 20:08:45,511 DEBUG : BROWSER_OUTPUT: |0;Richards;166.61112962345885 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.46781036709095 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.54648903691367 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5246.073298429319 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1089.3246187363834 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |5;Earley;720.9805335255949 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |6;Boyer;12481.481481481482 20:08:45 INFO - 2015-12-07 20:08:45,512 DEBUG : BROWSER_OUTPUT: |7;RegExp;26256.410256410258 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: |8;Splay;607.5334143377886 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: __startTimestamp1449547725510__endTimestamp 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,513 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:08:45 INFO - 2015-12-07 20:08:45,514 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:08:45 INFO - 2015-12-07 20:08:45,514 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,515 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.61 Median:166.61 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,515 DEBUG : BROWSER_OUTPUT: Values: 166.6 20:08:45 INFO - 2015-12-07 20:08:45,515 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.47 Median:184.47 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: Values: 184.5 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.55 Median:277.55 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: Values: 277.5 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5246.07 Median:5246.07 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: Values: 5246.1 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1089.32 Median:1089.32 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,516 DEBUG : BROWSER_OUTPUT: Values: 1089.3 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:720.98 Median:720.98 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: Values: 721.0 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12481.48 Median:12481.48 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: Values: 12481.5 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26256.41 Median:26256.41 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: Values: 26256.4 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:607.53 Median:607.53 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: Values: 607.5 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: 20:08:45 INFO - 2015-12-07 20:08:45,517 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 20:08:45 INFO - 2015-12-07 20:08:45,518 DEBUG : BROWSER_OUTPUT: Values: 4840.6 20:08:45 INFO - 2015-12-07 20:08:45,518 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:08:45 INFO - 2015-12-07 20:08:45,518 DEBUG : BROWSER_OUTPUT: 20:08:46 INFO - 2015-12-07 20:08:46,476 INFO : Browser exited with error code: 0 20:08:46 INFO - 2015-12-07 20:08:46,491 INFO : Completed test v8_7 (00:00:40) 20:08:46 INFO - 2015-12-07 20:08:46,969 INFO : Completed test suite (00:20:17) 20:08:46 INFO - 2015-12-07 20:08:46,969 DEBUG : Working with test: dromaeo_css 20:08:46 INFO - 2015-12-07 20:08:46,969 DEBUG : Generating results file: dromaeo_css 20:08:46 INFO - 2015-12-07 20:08:46,970 DEBUG : Working with test: kraken 20:08:46 INFO - 2015-12-07 20:08:46,970 DEBUG : Generating results file: kraken 20:08:46 INFO - 2015-12-07 20:08:46,971 INFO : javascript benchmark 20:08:46 INFO - 2015-12-07 20:08:46,971 DEBUG : Working with test: v8_7 20:08:46 INFO - 2015-12-07 20:08:46,971 DEBUG : Generating results file: v8_7 20:08:46 INFO - 2015-12-07 20:08:46,971 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:47 INFO - 2015-12-07 20:08:47,021 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,43]] 20:08:47 INFO - 2015-12-07 20:08:47,022 DEBUG : process_Request line: dromaeo_css 6264.14 graph.html#tests=[[72,94,43]] 20:08:47 INFO - 2015-12-07 20:08:47,022 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:47 INFO - 2015-12-07 20:08:47,053 DEBUG : process_Request line: kraken 1546.70 graph.html#tests=[[232,94,43]] 20:08:47 INFO - 2015-12-07 20:08:47,053 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:08:47 INFO - 2015-12-07 20:08:47,092 DEBUG : process_Request line: v8_7 21209.79 graph.html#tests=[[230,94,43]] 20:08:47 INFO - 2015-12-07 20:08:47,093 INFO : javascript benchmark 20:08:47 INFO - 2015-12-07 20:08:47,097 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2675.7856376207474, 2713.782897368211, 2744.6980832108466, 2755.6004379364995, 2760.4893094777467, 4584.151931892602, 4772.642051846108, 4808.254720518321, 4810.567048965592, 4813.855584332467, 4688.671792974493, 4699.2951057341415, 4715.858524244278, 4752.358431611731, 4794.736289504076, 4347.739135651863, 4418.779061046951, 4474.060447306069, 4478.507364189953, 4501.234790085677, 4403.779811009453, 4427.88930276744, 4436.689431739779, 4506.346579745935, 4525.275955847065, 4200.3699445083175, 4290.506591741959, 4323.3947247385395, 4411.250087485135, 4424.11517696462, 4418.823247070113, 4437.112577484516, 4441.400410944513, 4445.799939002753, 4484.439445069366, 4411.228035093878, 4416.734995900224, 4418.955810441918, 4458.732476051415, 4460.643148548141, 4427.734335939822, 4530.456345238559, 4616.469106052813, 4721.811127554894, 4763.333133361332, 5132.255822905658, 5156.561692256125, 5172.069027575035, 5175.585953123741, 5237.79048838046, 4967.081089998362, 5178.533931946105, 5201.219817027439, 5206.297149884755, 5211.140161873286, 4643.582077612963, 4715.7877895494785, 4747.596454301389, 4747.928781068286, 4762.095201911626, 5279.445658205833, 5307.389650190277, 5307.495787900143, 5314.256004159421, 5339.0, 5106.846794596168, 5114.616403769658, 5125.692458452505, 5131.7177555234075, 5134.717590532557, 4920.5571498565305, 5019.648624596243, 5021.899562008813, 5023.673461225008, 5030.723310217973, 4958.330625365529, 5009.574186194214, 5070.569001634903, 5074.949250507521, 5117.5905927526455, 5052.368453943257, 5065.518775716301, 5065.949340506548, 5071.036503064406, 5109.335786347751, 4082.530508991504, 4161.459010328698, 4214.4310518079665, 4279.716805365793, 4299.419578356944, 3619.2942376236906, 3684.1342284563107, 3694.6674799268194, 3713.628637136319, 3730.515033045687, 4401.273789824707, 4449.710768800018, 4467.084247729208, 4489.6408287336935, 4496.505384407713, 4870.09903167915, 5003.049420610072, 5018.924716129261, 5183.403908550489, 5202.557782588522, 4451.109778044404, 4467.798949047301, 4476.060027394218, 4503.729776213372, 4523.683342166082, 4560.95439045612, 4576.633869290449, 4587.678862479661, 4607.539246075366, 4639.976800115978, 4655.324977878188, 4700.2949557566635, 4784.091022705675, 4847.660663753503, 4866.391701037371, 5074.985002999489, 5085.211792172219, 5094.745262736922, 5128.640995130305, 5204.479552044765, 4843.200871856105, 4859.659823812299, 4882.9755851221935, 4889.584385327287, 4925.310456536159, 4772.379590653193, 4902.068606964665, 4987.950120498748, 5056.721880296619, 5132.743362831919, 5107.10625640504, 5163.896722065462, 5169.7673604687125, 5186.818461353985, 5215.869603259949, 4825.155597770447, 4990.6007519397635, 5004.799808007639, 5009.223570346602, 5013.423456302572, 4897.069556784199, 4918.065567542156, 4947.802087916443, 4985.4266759323145, 5007.84976450707, 4802.927956080592, 4846.878828029327, 4876.24418215163, 4876.878078048077, 4896.681715688469, 4782.545658162469, 4846.200376937766, 5003.724795136157, 5007.47421520735, 5041.369828771403, 4788.4253889533475, 4827.879303017453, 4849.102915960559, 4852.8544143675745, 4895.583875370491], "unit": "ms", "name": "dojo.html", "value": 4681.527874410921}, {"lowerIsBetter": false, "replicates": [523.1759978034596, 535.2132365422827, 538.927244821949, 544.3630951786411, 556.9053260945639, 35150.0, 35594.28811423773, 35641.64358356415, 35724.46413303796, 35726.46410303841, 39770.403443948366, 40265.798671006676, 40285.19429611406, 40442.39336409956, 40510.392344114865, 8006.91993080069, 8185.672573097069, 8190.713325033625, 8191.221833925797, 8209.179082091803, 7857.803554911145, 7994.440389172761, 8026.919730802676, 8030.196980301981, 8039.477433966774, 7925.643346049413, 7997.960010199941, 8025.478343907627, 8048.396370272224, 8070.596470176468, 7865.921340786605, 7950.681972721113, 7966.123726390092, 7966.6415011324625, 7967.800804979864, 7905.881411778828, 7997.480163789335, 8015.7595272141925, 8044.115147333789, 8055.31529819966, 36188.819055904816, 36449.453258201145, 36543.355549000094, 36606.0, 36626.45060324097, 2809.2134202423354, 2865.025891197003, 2887.2926133097317, 3348.296857659894, 3550.183457804719, 27934.860325698446, 28133.57799633007, 28200.576991345148, 28588.428231435253, 28738.425231495254, 3309.113018170217, 3340.799552026862, 3453.7755045921936, 3464.4630082337276, 3506.2461570762407, 200769.0, 202665.0, 203329.98335008378, 203545.0, 203946.0, 49788.0, 51286.743566282676, 52304.47695522996, 52458.475415246125, 52632.47367526352, 61765.38234617686, 63087.36912630815, 63129.68435157795, 63210.68394657997, 63453.68273158697, 12288.447019883948, 12363.876361236273, 12365.938170309271, 12377.071719621064, 12405.689857753629, 10349.689509314732, 10397.220208484394, 10423.5830566778, 10437.32157409766, 10470.424126672953, 18050.18774155166, 18485.075746212904, 18512.44462666122, 18525.629487410446, 18547.629047419246, 7417.33244008031, 7751.961240193876, 7758.495697779626, 7794.2985131338455, 7811.257930496594, 847.7329641163014, 865.8701194820827, 866.7009881590841, 900.8288425199322, 962.0, 25858.87070564673, 26111.477770444486, 27103.186904392507, 27322.45355092887, 27452.588211176848, 923.93532452729, 978.9118979291756, 985.669800616787, 1010.1161483701761, 1059.6873922192972, 14106.294685265695, 14398.40828650832, 14504.202268875313, 14746.115233085835, 14805.259737013323, 260421.0, 262815.0, 264899.0, 265969.0, 265983.0, 41981.79009104996, 42044.579554204065, 42145.578544214775, 42292.57707422948, 42379.0, 1214.9210301330386, 1236.771197328497, 1242.2918936206277, 1272.5609664665676, 1273.325137677014, 26771.598426024015, 26781.001980415276, 27074.864625677532, 27169.0, 27250.0, 39458.0, 39469.2106157881, 39509.20981580295, 39834.0, 39857.80071099742, 251459.0, 252488.0, 252717.0, 252936.0, 254005.0, 27664.861675692297, 30822.383552329276, 31080.68919310778, 31289.8435507821, 31303.530447042856, 36171.27657446784, 36852.262954741294, 36989.26021479609, 37248.255034899696, 37517.81241093777, 31303.217419564695, 31566.0, 31584.368312634077, 32478.0, 32921.0, 31586.052418426563, 31935.201619959687, 32046.35907281888, 32074.35851283008, 32196.35607287888, 30107.69892301049, 30193.245168870955, 30378.0, 30578.541321879744, 30772.53841192339, 28112.29719257035, 28984.275393115342, 30567.0, 30671.846640766653, 30880.53679194769, 21589.13643454244, 22074.44813879666, 24072.277831665077, 24090.63864042076, 24723.87638061798], "unit": "ms", "name": "ext.html", "value": 16708.523661133786}, {"lowerIsBetter": false, "replicates": [272.93995321029394, 273.1886297695843, 275.79591102584095, 279.8418893325271, 286.28571713574627, 13825.654358641039, 14005.0, 15233.086014839117, 15629.84370156298, 15665.138417387054, 9850.310478266525, 10095.596176152963, 10117.089461948422, 14674.633134171625, 16065.357385704558, 4504.752238626874, 4591.1965406053805, 4626.606738427221, 4643.257078867382, 4655.813767449298, 4678.204705200124, 4810.9037819243595, 4976.129177393959, 4977.278294647274, 4977.576905962979, 4701.553352431513, 4865.635077369194, 4892.168331383656, 4933.777979990909, 4946.802127914897, 4919.286703428001, 4924.655274130831, 4936.5063493650705, 4939.135651261033, 4941.530554597308, 4643.88390290242, 4728.810847566093, 4762.6904251223905, 4786.617070634341, 4805.8558243252755, 11132.888671113347, 11213.327200368005, 11351.489182986703, 18673.346432874783, 19324.0, 1723.638036012439, 1770.2122555462824, 1809.5566586186337, 1827.3330234464458, 1929.4211736479, 8737.650493980233, 8942.731718048404, 8971.685990990283, 11207.495662695199, 12659.30373829439, 1753.9035353055576, 1758.2088060372755, 1780.1010489702746, 1801.774778152731, 1813.1115753280928, 53815.19277210845, 56169.43830561683, 56310.436895630926, 56448.0, 56633.0, 9269.490178040138, 9347.112024357675, 9509.286803489627, 9556.092171243721, 9600.279979001603, 11785.410729463663, 11785.646430606925, 11799.52801887932, 11831.526738930346, 11843.526258949545, 6969.721211151598, 7010.298970103051, 7063.399611033017, 7130.0, 7149.285071492913, 6941.652917354112, 6944.4097251734165, 6955.6869940852785, 6967.0, 6991.09115814951, 3713.7586056906757, 3793.696504279651, 3794.5636251830842, 3856.9971807329734, 3859.459675645412, 1600.7278762610383, 1655.5364497940595, 1702.9744553831702, 1707.0525858148847, 1720.2602880761142, 863.4258218284896, 878.4509681449094, 886.8802711633847, 923.8060007398387, 926.6895589977433, 14913.179775112256, 14914.0, 15032.774508382383, 15290.923545382202, 15355.155466449452, 838.9916100838914, 858.9871151932726, 865.16079402979, 889.1952782731638, 894.7092195036639, 9118.726438206864, 9127.680531181377, 9177.495237761987, 9200.631974721071, 9278.860817087749, 443738.0, 447991.0, 454917.0, 458386.0, 461526.0, 68469.65765171142, 71639.64180179065, 71862.0, 72293.63853180701, 72421.27578724251, 978.9706308810747, 984.2863923655293, 991.2317953585884, 992.9602815887428, 1027.5735569738624, 14071.859281407464, 14210.25406362561, 14294.857051429353, 14381.424743010162, 14573.125612463286, 33192.502112467846, 33295.99999999903, 33881.49177762385, 34177.0, 34611.653883460844, 42928.78535607302, 43949.0, 44412.77793611011, 46089.0, 47509.0, 8984.513417878266, 9076.546172691471, 9192.034836342087, 9283.860742088738, 9298.628054877729, 16149.919250404142, 16392.180390980164, 16561.83438165603, 16831.326746929986, 16831.41090061842, 13483.123596966167, 13534.526291579747, 13593.52422665202, 13727.45090196381, 14305.0, 12887.453505579391, 13369.66575835612, 13371.197728136343, 13682.31588420595, 13932.233727145105, 13765.655858603615, 13997.860021399656, 14190.432382704576, 14203.076800007966, 14290.0, 8539.530325832138, 8617.526036067826, 8630.611622477129, 9119.088091190828, 9125.361224714206, 10452.581896724047, 14057.0, 14141.292935352985, 14172.563625077591, 14238.430462781787], "unit": "ms", "name": "jquery.html", "value": 8056.582493765688}, {"lowerIsBetter": false, "replicates": [1402.4109873852988, 1421.268046955818, 1479.4599971010584, 1635.8691304695622, 1723.870709696773, 5798.797042103527, 6097.5426842986735, 7191.2808719128125, 7290.854182916339, 7307.780766577004, 6606.075149479077, 6807.795766127024, 6847.212570554375, 6848.10974573306, 6865.210500792398, 2035.2673037706413, 2067.131804642054, 2067.514134178467, 2072.1400618743205, 2072.8549001569822, 2038.520947577318, 2075.4915045813796, 2078.5738923520644, 2085.906134223956, 2097.4336929029155, 2026.8074532919422, 2037.7758446570865, 2057.341650671778, 2059.063126277548, 2065.411357763038, 2058.1664425907456, 2076.5431605046865, 2081.6357137500954, 2082.645950188464, 2087.217293514932, 2007.7389939307943, 2026.432598872318, 2029.7158397824317, 2032.471557395088, 2063.3912995666315, 7089.645517724093, 7167.605781682006, 7172.390346820526, 7190.604516751577, 7223.530470519452, 4051.3112770828734, 4073.3075377185655, 4092.631663150331, 4104.015036391274, 4127.504699436057, 2622.8426294422206, 2667.2798344447083, 2702.067786613615, 2714.8506832124226, 2715.5383584790634, 843.9367047471403, 852.654674856684, 867.5965675960646, 869.6477926439802, 883.1389395339556, 9038.186563209278, 9086.727398178065, 9089.818203635956, 9110.088991100904, 9152.313576481723, 3614.4578313252696, 3635.4728564358547, 3653.50677658518, 3656.1225305926387, 3668.0463079599494, 7802.687892484237, 7838.098618658813, 7844.176361482077, 7857.646405911748, 7895.526268423913, 4045.5145382554283, 4056.51321841375, 4060.2285565742413, 4064.451299074646, 4085.346344584852, 3125.687431256856, 3213.53403756454, 3498.8425520851624, 3720.2187540616774, 3730.3658378075793, 3275.3121844412462, 3374.713149382281, 3374.797512149279, 3407.744419168572, 3418.9829050854587, 1056.1181413519796, 1058.9894101059044, 1068.5779117248644, 1068.9625863094755, 1074.9247552671395, 1106.4080716816625, 1115.2472081345059, 1121.315997241682, 1128.6839684888243, 1146.564305563897, 6505.316941721146, 6512.185976752906, 6513.967430162819, 6533.444657204191, 6567.0, 1076.4832880217539, 1119.6081371519904, 1137.4142316706902, 1141.3836528274805, 1152.2107356460851, 4884.918798073561, 5046.44489106198, 5083.161278389024, 5083.415407228216, 5084.51697088776, 8489.660413583511, 8682.262007729287, 8741.125887411335, 8772.517511536927, 8792.824143517222, 8438.156184381636, 8590.742277731679, 8613.78465538354, 8641.395102342902, 8705.608247628745, 6733.494987875929, 6751.0, 6806.285340039323, 6810.5913645181445, 6850.9314906850295, 6190.659513726789, 6292.276388215414, 6310.558260921875, 6311.90532142009, 6312.936870631235, 7629.0845098588525, 7711.228877112244, 7724.304812566896, 7753.612319383896, 7831.334336581454, 7783.494072885244, 7959.880601791094, 7994.760157195294, 8001.479903806234, 8009.679612815422, 4934.950650493449, 5023.824166154313, 5841.707914604168, 5906.881862362815, 5909.438603332676, 6241.126242325987, 6427.292997770335, 6444.8388790280615, 6501.642409667514, 6504.804855854332, 6111.755529778937, 6131.877362452815, 6139.3553676863285, 6243.032329988859, 6318.873622527615, 6117.449429551361, 6194.256689197145, 6241.750329986749, 6317.305096439296, 6364.109024736448, 6448.355164483702, 6480.384363485461, 6481.967590162019, 6483.870322593428, 6486.351364863476, 5849.093390524476, 5850.444207800252, 5906.202662640489, 5906.70466476683, 5918.852028699144, 5886.499647529837, 5930.970345148246, 5937.495312898279, 5964.761409543569, 5976.223090998316], "unit": "ms", "name": "mootools.html", "value": 4024.446593984082}, {"lowerIsBetter": false, "replicates": [255.3539544951274, 256.8946731839946, 256.95246379419797, 262.96844378674564, 263.67699568029167, 5518.724063796809, 5588.7205639718, 5600.019996500611, 5610.13042978338, 5756.654600723949, 5536.280283563141, 5563.638363506369, 5612.045952188128, 5624.493795558399, 5629.577781666371, 4062.6343629073453, 4139.689523285766, 4143.917121657565, 4144.875653730378, 4158.521769996459, 4127.29835927893, 4154.169166166764, 4166.6666666666615, 4185.309423945046, 4204.444355588436, 4145.316022856225, 4149.439825623547, 4150.128473020669, 4150.896227594304, 4156.459660244164, 4132.834686612532, 4150.149219410029, 4151.481064866892, 4152.37714342848, 4156.127213285214, 3407.812570308632, 3408.6761757632985, 3476.600190978045, 3487.7209823214334, 3535.9646403535894, 5305.204219367087, 5323.254744335796, 5356.491133342326, 5362.517373436371, 5370.8925821483745, 4744.667873248874, 4745.145873742725, 4756.025014871943, 4757.357756702835, 4757.976210118927, 5829.0, 5835.124731290298, 5839.153322768218, 5848.327442344143, 5857.297124345106, 3706.796126213057, 3821.159344944108, 3842.077901303667, 3845.2309538092213, 3847.7883716395586, 6145.446909778141, 6188.907166392508, 6210.968945155245, 6220.129181914535, 6227.501799856001, 3866.2267546490816, 3876.6898648108086, 3882.6699730523223, 3884.3396622574232, 3901.5903330150495, 3940.3498422760495, 3943.0, 3943.211357728466, 3948.269570129535, 3952.3478626026385, 4581.221192397234, 4681.110588988081, 4686.437627484655, 4692.296155576691, 4707.6233901287815, 5893.5874488785375, 5912.73392697321, 5915.852103697442, 5915.881682366328, 5919.260092488439, 1386.0090035624376, 1390.6731917999261, 1401.2643362234908, 1404.8243969503812, 1408.3732738931078, 869.5347988825948, 880.7621942075604, 890.950997695133, 897.7576054465388, 898.6899519665704, 5141.614378921596, 5177.948220517822, 5191.870203244949, 5192.792288308426, 5216.66091704038, 6168.0439531872635, 6170.352113028068, 6171.506279497629, 6171.876562468726, 6175.907361389583, 5173.560247379015, 5183.663061900965, 5188.377394712583, 5190.948090519122, 5192.0, 3241.497567876983, 3322.0200040987966, 3326.634070252319, 3328.6172090209934, 3332.183615014337, 5682.914756278659, 5791.826245212566, 5803.448672376117, 5810.593258471867, 5831.979403604352, 6284.560080794392, 6286.277078136073, 6309.801137783898, 6325.05124231369, 6392.456641185551, 5849.1226316052935, 5850.64896106235, 5870.618409803349, 5871.295444546597, 5873.177755114202, 6033.366496517802, 6145.0, 6191.349908259568, 6192.628442293477, 6199.752009919553, 6028.367021462684, 6068.969655151696, 6096.847578810565, 6107.877842443215, 6110.633361998294, 5787.305523337226, 5853.2390789198835, 5857.677827719346, 5861.648301101947, 5870.119482077723, 3929.115948911472, 3979.960200397959, 4021.738586991836, 4026.979865100656, 4031.072853243829, 6092.45167934888, 6094.421030002142, 6108.419700128481, 6109.725062372115, 6124.38756124384, 5894.410558944071, 5918.733656985532, 5920.555958303058, 5927.0, 5935.0207215808905, 5830.416958304136, 5887.852803679943, 5907.4683278505145, 5916.230889984275, 5933.050711886078, 5605.467480589337, 5731.8853622928145, 5742.0, 5774.595778295479, 5782.566307527037, 5914.3198532167635, 5917.674527900835, 5927.199828023334, 5929.318128415288, 5942.554308426799, 5748.166515855261, 5771.163181338598, 5787.160861674949, 5788.0, 5800.39095894925], "unit": "ms", "name": "prototype.html", "value": 4304.718597903267}, {"lowerIsBetter": false, "replicates": [673.464595646461, 682.2870100744722, 693.8889777635576, 738.8005238585586, 742.9554226746395, 10760.946195269022, 10877.401742904138, 11015.779684406318, 11023.944880275587, 11025.338479691223, 11331.716707082307, 11797.823032654516, 11799.764004719922, 11829.290242585452, 11844.289342639448, 776.8252143267762, 781.1056340490164, 782.0615261685971, 804.859149648812, 806.9354451643854, 785.1167436633787, 785.8271180340345, 790.6639678136769, 790.9802254943614, 791.5448617045222, 791.1337085890968, 820.4666966471782, 829.4567058576642, 830.3440282177073, 831.476170012894, 818.5907046476761, 823.3084209264217, 824.3940703582862, 825.2613910550084, 826.0294154368593, 607.4441885674603, 610.4993904997904, 610.5359926455881, 610.7160170520684, 610.9816705498843, 12001.699957501045, 12185.086118541145, 12188.634340969786, 12189.878101218963, 12201.38993050344, 10816.783664326747, 11247.55009799607, 11392.772144557146, 11476.426178691032, 11657.533698652043, 9083.954580227057, 9291.0, 9350.205232555241, 9436.716898493056, 9465.479398633073, 3251.983740081308, 3264.363449127421, 3305.983470082658, 3308.4375656138513, 3340.048086295418, 40335.19329613421, 40436.393454098215, 40526.594734052574, 40705.796471018046, 40719.0, 8046.517208967481, 8090.069641991128, 8161.183881611792, 8170.223828736261, 8306.335493160654, 14915.328810203568, 14994.62513437151, 15163.0, 15222.238888055554, 15294.923525382303, 6230.06549017651, 6292.968535157295, 6351.237851457762, 6373.776917807854, 6458.095866578588, 3595.173110184672, 3614.9096272593397, 3629.891103266906, 3655.597884232732, 3681.466187402865, 2595.0398352609654, 2623.6851577810785, 2627.3037645024083, 2628.4217472156097, 2634.5257853586154, 467.1544504446962, 471.61327711276425, 481.1988039913505, 483.079733108429, 486.8125771577968, 551.181495479213, 552.8479668091308, 573.3549756523911, 591.2550186764621, 616.1681729664916, 7876.448648594658, 7984.560849153352, 8087.393445491612, 8132.878006829902, 8197.139300373376, 501.3707796715099, 568.8622754491018, 582.0, 613.6992873491956, 625.0624063904144, 3579.7494175407473, 3609.530761001053, 3639.70882329413, 3794.1083845296334, 3858.3826587745825, 47117.76441117841, 47730.5226947733, 48053.0, 48473.75763121162, 48966.51033489619, 43186.35220471695, 43463.34804977928, 44242.557574423845, 44300.556994430284, 44439.33340999888, 38992.22015559729, 39046.609533904295, 39380.0, 39521.0, 39996.20007599832, 7341.192468828532, 7385.519941204019, 7431.36833369148, 7561.621918904143, 7677.9232207677205, 30559.54160687636, 30694.84652576723, 30860.382792344477, 30869.382612347177, 31030.22424439407, 35685.82157089198, 35964.0, 38799.22401552009, 39082.41376379413, 39203.41194882136, 8936.28509719208, 9002.099790020946, 9051.366404351633, 9159.679411220843, 9241.86137207929, 9958.800823983625, 10058.748531286483, 10214.131798796889, 10214.642487512901, 10263.384196948207, 9951.751206219902, 9981.151602113901, 10059.899401005896, 10068.24488163376, 10180.371140617763, 8909.1536304051, 9058.0, 9108.954455227946, 9164.633414663338, 9450.385724927857, 8757.649694012169, 9159.679411220843, 9395.107464790834, 9428.481433521221, 9469.289803264921, 8070.2333278338465, 8141.22658347456, 8250.711225107092, 8322.0, 8464.44981076228, 7926.801829954297, 8123.228293312126, 8321.500709957421, 8704.956475217583, 9028.503432311023], "unit": "ms", "name": "yui.html", "value": 5533.455404867874}], "name": "dromaeo_css", "value": 6264.137896707929}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 107.0, 114.0, 114.0, 117.0, 126.0, 114.0, 115.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [162.0, 131.0, 155.0, 168.0, 132.0, 152.0, 157.0, 133.0, 166.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.7}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 161.0, 162.0, 163.0, 165.0, 168.0, 163.0, 165.0, 166.0], "unit": "ms", "name": "audio-dft", "value": 164.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 72.0, 75.0, 74.0, 131.0, 79.0, 79.0, 73.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 129.0, 95.0, 95.0, 94.0, 133.0, 94.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 147.0, 150.0, 148.0, 150.0, 148.0, 148.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 97.0, 96.0, 97.0, 96.0, 96.0, 97.0, 96.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [76.0, 76.0, 74.0, 75.0, 75.0, 76.0, 76.0, 77.0, 77.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 75.6}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 93.0, 85.0, 90.0, 95.0, 85.0, 84.0, 87.0, 96.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 88.2}, {"lowerIsBetter": true, "replicates": [130.0, 130.0, 125.0, 120.0, 121.0, 134.0, 122.0, 131.0, 127.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.6}, {"lowerIsBetter": true, "replicates": [138.0, 149.0, 157.0, 151.0, 148.0, 150.0, 149.0, 154.0, 154.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 73.0, 73.0, 69.0, 69.0, 68.0, 68.0, 72.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.6}], "name": "kraken", "value": 1546.6999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.61112962345885], "unit": "score", "name": "Richards", "value": 211.88260400000004}, {"lowerIsBetter": false, "replicates": [184.46781036709095], "unit": "score", "name": "DeltaBlue", "value": 358.42567799999995}, {"lowerIsBetter": false, "replicates": [277.54648903691367], "unit": "score", "name": "Encrypt", "value": 959.0501430000003}, {"lowerIsBetter": false, "replicates": [5246.073298429319], "unit": "score", "name": "Decrypt", "value": 50.739092814371276}, {"lowerIsBetter": false, "replicates": [1089.3246187363834], "unit": "score", "name": "RayTrace", "value": 679.3099019999999}, {"lowerIsBetter": false, "replicates": [720.9805335255949], "unit": "score", "name": "Earley", "value": 924.3841810000001}, {"lowerIsBetter": false, "replicates": [12481.481481481482], "unit": "score", "name": "Boyer", "value": 53.39614540059344}, {"lowerIsBetter": false, "replicates": [26256.410256410258], "unit": "score", "name": "RegExp", "value": 34.69571777343749}, {"lowerIsBetter": false, "replicates": [607.5334143377886], "unit": "score", "name": "Splay", "value": 134.13418600000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21209.787357036024}]} 20:08:47 INFO - RETURN: dromaeo_css: 6264.14 20:08:47 INFO - RETURN: kraken: 1546.70 20:08:47 INFO - RETURN: v8_7: 21209.79 20:08:47 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,43]]", "result": "21209.79"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,43]]", "result": "1546.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,43]]", "result": "6264.14"}}} 20:08:47 INFO - Return code: 0 20:08:47 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:08:47 INFO - # TBPL SUCCESS # 20:08:47 INFO - Running post-action listener: _resource_record_post_action 20:08:47 INFO - Running post-run listener: _resource_record_post_run 20:08:48 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 505257984; Read time: 16; Write time: 509864 20:08:48 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 231403520; Read time: 0; Write time: 260528 20:08:48 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 272961536; Read time: 16; Write time: 249268 20:08:48 INFO - Running post-run listener: _upload_blobber_files 20:08:48 INFO - Blob upload gear active. 20:08:48 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:08:48 INFO - Copying logs to upload dir... 20:08:48 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1281.319154 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2015-12-07 20:08:47.195387) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 20:08:47.198976) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010273 build_url: 'https://queue.taskcluster.net/v1/task/GXOGNOn2TWCNKwY3f5crqA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.05 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 20:08:47.255413) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:08:47.256229) ========= 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=6e558709db315bacd2260379000001b6-1449529505.270412-1381483002 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004531 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:08:47.311229) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:08:47.312016) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:08:47.312795) ========= ========= Total master_lag: 0.25 =========