builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1449547173.31 results: success (0) buildid: 20151207183825 builduid: 582424eae2754e808b005dab9f10399e revision: d08afef8b42d1f481dc5f9cca8df35ed0a848836 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.311910) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.312467) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.312861) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006383 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.349979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.350281) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.376372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.376639) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004548 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.427915) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.428184) ========= 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:59:33.428573) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.428844) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 19:59:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.0M=0s 2015-12-07 19:59:33 (47.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.174320 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.615822) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.616101) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019731 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.666827) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-07 19:59:33.667443) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --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 integration/fx-team --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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 19:59:33,825 truncating revision to first 12 chars 2015-12-07 19:59:33,825 Setting DEBUG logging. 2015-12-07 19:59:33,825 attempt 1/10 2015-12-07 19:59:33,825 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d08afef8b42d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-07 19:59:34,696 unpacking tar archive at: fx-team-d08afef8b42d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.156266 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-07 19:59:34.836992) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.837321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.846268) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.846877) ========= 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:59:34.847441) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-07 19:59:34.847729) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 19:59:35 INFO - MultiFileLogger online at 20151207 19:59:35 in /builds/slave/test 19:59:35 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 19:59:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 19:59:35 INFO - {'append_to_log': False, 19:59:35 INFO - 'base_work_dir': '/builds/slave/test', 19:59:35 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 19:59:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 19:59:35 INFO - 'branch': 'Fx-Team-Non-PGO', 19:59:35 INFO - 'buildbot_json_path': 'buildprops.json', 19:59:35 INFO - 'config_files': ('talos/linux_config.py',), 19:59:35 INFO - 'default_actions': ('clobber', 19:59:35 INFO - 'read-buildbot-config', 19:59:35 INFO - 'download-and-extract', 19:59:35 INFO - 'populate-webroot', 19:59:35 INFO - 'create-virtualenv', 19:59:35 INFO - 'install', 19:59:35 INFO - 'run-tests'), 19:59:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 19:59:35 INFO - 'download_minidump_stackwalk': True, 19:59:35 INFO - 'download_symbols': 'ondemand', 19:59:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 19:59:35 INFO - 'tooltool.py': '/tools/tooltool.py', 19:59:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 19:59:35 INFO - '/tools/misc-python/virtualenv.py')}, 19:59:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 19:59:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 19:59:35 INFO - 'installer_path': 'installer.exe', 19:59:35 INFO - 'log_level': 'info', 19:59:35 INFO - 'log_name': 'talos', 19:59:35 INFO - 'log_to_console': True, 19:59:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 19:59:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 19:59:35 INFO - 'opt_config_files': (), 19:59:35 INFO - 'pip_index': False, 19:59:35 INFO - 'sps_profile': False, 19:59:35 INFO - 'sps_profile_interval': 0, 19:59:35 INFO - 'suite': 'dromaeojs', 19:59:35 INFO - 'system_bits': '64', 19:59:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:35 INFO - 'title': 'talos-linux64-ix-047', 19:59:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 19:59:35 INFO - 'use_talos_json': True, 19:59:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 19:59:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 19:59:35 INFO - 'work_dir': 'build'} 19:59:35 INFO - ##### 19:59:35 INFO - ##### Running clobber step. 19:59:35 INFO - ##### 19:59:35 INFO - Running pre-action listener: _resource_record_pre_action 19:59:35 INFO - Running main action method: clobber 19:59:35 INFO - rmtree: /builds/slave/test/build 19:59:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 19:59:35 INFO - Running post-action listener: _resource_record_post_action 19:59:35 INFO - ##### 19:59:35 INFO - ##### Running read-buildbot-config step. 19:59:35 INFO - ##### 19:59:35 INFO - Running pre-action listener: _resource_record_pre_action 19:59:35 INFO - Running main action method: read_buildbot_config 19:59:35 INFO - Using buildbot properties: 19:59:35 INFO - { 19:59:35 INFO - "properties": { 19:59:35 INFO - "buildnumber": 992, 19:59:35 INFO - "product": "firefox", 19:59:35 INFO - "script_repo_revision": "production", 19:59:35 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 19:59:35 INFO - "repository": "", 19:59:35 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 19:59:35 INFO - "buildid": "20151207183825", 19:59:35 INFO - "slavename": "talos-linux64-ix-047", 19:59:35 INFO - "pgo_build": "False", 19:59:35 INFO - "basedir": "/builds/slave/test", 19:59:35 INFO - "project": "", 19:59:35 INFO - "platform": "ubuntu64_hw", 19:59:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:59:35 INFO - "slavebuilddir": "test", 19:59:35 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:59:35 INFO - "branch": "fx-team", 19:59:35 INFO - "repo_path": "integration/fx-team", 19:59:35 INFO - "stage_platform": "linux64", 19:59:35 INFO - "builduid": "582424eae2754e808b005dab9f10399e", 19:59:35 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:35 INFO - }, 19:59:35 INFO - "sourcestamp": { 19:59:35 INFO - "repository": "", 19:59:35 INFO - "hasPatch": false, 19:59:35 INFO - "project": "", 19:59:35 INFO - "branch": "fx-team-linux64-talos", 19:59:35 INFO - "changes": [ 19:59:35 INFO - { 19:59:35 INFO - "category": null, 19:59:35 INFO - "files": [ 19:59:35 INFO - { 19:59:35 INFO - "url": null, 19:59:35 INFO - "name": "https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 19:59:35 INFO - } 19:59:35 INFO - ], 19:59:35 INFO - "repository": "", 19:59:35 INFO - "rev": "d08afef8b42d1f481dc5f9cca8df35ed0a848836", 19:59:35 INFO - "who": "philringnalda@gmail.com", 19:59:35 INFO - "when": 1449547111, 19:59:35 INFO - "number": 7016645, 19:59:35 INFO - "comments": "Bug 1162813: filter paragraph separators before passing text to SetPara, r=jfkthame", 19:59:35 INFO - "project": "", 19:59:35 INFO - "at": "Mon 07 Dec 2015 19:58:31", 19:59:35 INFO - "branch": "fx-team-linux64-talos", 19:59:35 INFO - "revlink": "", 19:59:35 INFO - "properties": [ 19:59:35 INFO - [ 19:59:35 INFO - "buildid", 19:59:35 INFO - "20151207183825", 19:59:35 INFO - "Change" 19:59:35 INFO - ], 19:59:35 INFO - [ 19:59:35 INFO - "builduid", 19:59:35 INFO - "582424eae2754e808b005dab9f10399e", 19:59:35 INFO - "Change" 19:59:35 INFO - ], 19:59:35 INFO - [ 19:59:35 INFO - "pgo_build", 19:59:35 INFO - "False", 19:59:35 INFO - "Change" 19:59:35 INFO - ] 19:59:35 INFO - ], 19:59:35 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:35 INFO - } 19:59:35 INFO - ], 19:59:35 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:35 INFO - } 19:59:35 INFO - } 19:59:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 19:59:35 INFO - Running post-action listener: _resource_record_post_action 19:59:35 INFO - ##### 19:59:35 INFO - ##### Running download-and-extract step. 19:59:35 INFO - ##### 19:59:35 INFO - Running pre-action listener: _resource_record_pre_action 19:59:35 INFO - Running main action method: download_and_extract 19:59:35 INFO - mkdir: /builds/slave/test/build/tests 19:59:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:35 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:59:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json 19:59:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json 19:59:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 19:59:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 19:59:40 INFO - Downloaded 1302 bytes. 19:59:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:59:40 INFO - Using the following test package requirements: 19:59:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'jsshell-linux-x86_64.zip'], 19:59:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:40 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:59:40 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:41 INFO - Downloaded 21860240 bytes. 19:59:41 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:59:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:41 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:59:42 INFO - Return code: 0 19:59:42 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:59:42 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:59:42 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 19:59:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:44 INFO - Downloaded 21860240 bytes. 19:59:44 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 19:59:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:44 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 19:59:45 INFO - Return code: 0 19:59:45 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:59:45 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 19:59:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:46 INFO - Downloaded 11132074 bytes. 19:59:46 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:59:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:46 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:59:46 INFO - Return code: 0 19:59: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:59:46 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 19:59:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:59:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:59:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/unRCPlr-RACK9L0f5-E0AQ/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:59:48 INFO - Downloaded 57728703 bytes. 19:59:48 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:59:48 INFO - mkdir: /builds/slave/test/properties 19:59:48 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:48 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:48 INFO - Contents: 19:59:48 INFO - build_url:https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - Running post-action listener: set_extra_try_arguments 19:59:48 INFO - ##### 19:59:48 INFO - ##### Running populate-webroot step. 19:59:48 INFO - ##### 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: populate_webroot 19:59:48 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:48 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:48 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:59:48 INFO - '../fennec_ids.txt'], 19:59:48 INFO - 'tests': ['tcheck2']}, 19:59:48 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:48 INFO - '--tppagecycles', 19:59:48 INFO - '7'], 19:59:48 INFO - 'tests': ['tsvgm']}}, 19:59:48 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:48 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:48 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:48 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:48 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['damp', 'tps']}, 19:59:48 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:48 INFO - 'other': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other_l64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:48 INFO - 'ts_paint', 19:59:48 INFO - 'tpaint', 19:59:48 INFO - 'sessionrestore', 19:59:48 INFO - 'sessionrestore_no_auto_restore']}, 19:59:48 INFO - 'svgr': {'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tsvgx', 19:59:48 INFO - 'tsvgr_opacity', 19:59:48 INFO - 'tart', 19:59:48 INFO - 'tscrollx', 19:59:48 INFO - 'cart']}, 19:59:48 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s'], 19:59:48 INFO - 'tests': ['tp5o']}, 19:59:48 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}, 19:59:48 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:48 INFO - 'talos_options': ['--e10s', 19:59:48 INFO - '--xperf_path', 19:59:48 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:48 INFO - 'tests': ['tp5n']}}, 19:59:48 INFO - 'talos.zip': {'path': '', 19:59:48 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:48 INFO - Running post-action listener: _resource_record_post_action 19:59:48 INFO - ##### 19:59:48 INFO - ##### Running create-virtualenv step. 19:59:48 INFO - ##### 19:59:48 INFO - Running pre-action listener: _resource_record_pre_action 19:59:48 INFO - Running main action method: create_virtualenv 19:59:48 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:48 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:59:48 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:48 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:48 INFO - Using real prefix '/usr' 19:59:48 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:48 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:50 INFO - Installing pip.................done. 19:59:50 INFO - Return code: 0 19:59:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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:59:50 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:59:50 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:59:50 INFO - Using env: {'DISPLAY': ':0', 19:59:50 INFO - 'HOME': '/home/cltbld', 19:59:50 INFO - 'LANG': 'en_US.UTF-8', 19:59:50 INFO - 'LANGUAGE': 'en_US:en', 19:59:50 INFO - 'LOGNAME': 'cltbld', 19:59:50 INFO - 'MAIL': '/var/mail/cltbld', 19:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:50 INFO - 'MOZ_NO_REMOTE': '1', 19:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:50 INFO - 'NO_EM_RESTART': '1', 19:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:50 INFO - 'PWD': '/builds/slave/test', 19:59:50 INFO - 'SHELL': '/bin/bash', 19:59:50 INFO - 'SHLVL': '1', 19:59:50 INFO - 'TERM': 'linux', 19:59:50 INFO - 'TMOUT': '86400', 19:59:50 INFO - 'USER': 'cltbld', 19:59:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 19:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:50 INFO - '_': '/tools/buildbot/bin/python'} 19:59:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:50 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:59:50 INFO - Cleaning up... 19:59:50 INFO - Return code: 0 19:59:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:50 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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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:59:50 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:59:50 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:59:50 INFO - Using env: {'DISPLAY': ':0', 19:59:50 INFO - 'HOME': '/home/cltbld', 19:59:50 INFO - 'LANG': 'en_US.UTF-8', 19:59:50 INFO - 'LANGUAGE': 'en_US:en', 19:59:50 INFO - 'LOGNAME': 'cltbld', 19:59:50 INFO - 'MAIL': '/var/mail/cltbld', 19:59:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:50 INFO - 'MOZ_NO_REMOTE': '1', 19:59:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:50 INFO - 'NO_EM_RESTART': '1', 19:59:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:50 INFO - 'PWD': '/builds/slave/test', 19:59:50 INFO - 'SHELL': '/bin/bash', 19:59:50 INFO - 'SHLVL': '1', 19:59:50 INFO - 'TERM': 'linux', 19:59:50 INFO - 'TMOUT': '86400', 19:59:50 INFO - 'USER': 'cltbld', 19:59:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 19:59:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:50 INFO - '_': '/tools/buildbot/bin/python'} 19:59:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:51 INFO - Downloading/unpacking psutil>=0.7.1 19:59:51 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:59:51 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:59:51 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:59:51 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:59:51 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:59:51 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:59:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 19:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:52 INFO - Installing collected packages: psutil 19:59:52 INFO - Running setup.py install for psutil 19:59:52 INFO - building 'psutil._psutil_linux' extension 19:59:52 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:59:53 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:59:53 INFO - building 'psutil._psutil_posix' extension 19:59:53 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:59:53 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:59:53 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:53 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:53 INFO - Successfully installed psutil 19:59:53 INFO - Cleaning up... 19:59:53 INFO - Return code: 0 19:59:53 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 19:59:53 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:59:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 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:59:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:53 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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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:59:53 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:59:53 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:59:53 INFO - Using env: {'DISPLAY': ':0', 19:59:53 INFO - 'HOME': '/home/cltbld', 19:59:53 INFO - 'LANG': 'en_US.UTF-8', 19:59:53 INFO - 'LANGUAGE': 'en_US:en', 19:59:53 INFO - 'LOGNAME': 'cltbld', 19:59:53 INFO - 'MAIL': '/var/mail/cltbld', 19:59:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:53 INFO - 'MOZ_NO_REMOTE': '1', 19:59:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:53 INFO - 'NO_EM_RESTART': '1', 19:59:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:53 INFO - 'PWD': '/builds/slave/test', 19:59:53 INFO - 'SHELL': '/bin/bash', 19:59:53 INFO - 'SHLVL': '1', 19:59:53 INFO - 'TERM': 'linux', 19:59:53 INFO - 'TMOUT': '86400', 19:59:53 INFO - 'USER': 'cltbld', 19:59:53 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 19:59:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:53 INFO - '_': '/tools/buildbot/bin/python'} 19:59:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:53 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:59:55 INFO - Downloading mozsystemmonitor-0.0.tar.gz 19:59:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:55 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:59:55 INFO - Installing collected packages: mozsystemmonitor 19:59:55 INFO - Running setup.py install for mozsystemmonitor 19:59:55 INFO - Successfully installed mozsystemmonitor 19:59:55 INFO - Cleaning up... 19:59:55 INFO - Return code: 0 19:59:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59: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:59:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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:59:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59: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', '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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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:59: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:59: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 blobuploader==1.2.4 19:59:55 INFO - Using env: {'DISPLAY': ':0', 19:59:55 INFO - 'HOME': '/home/cltbld', 19:59:55 INFO - 'LANG': 'en_US.UTF-8', 19:59:55 INFO - 'LANGUAGE': 'en_US:en', 19:59:55 INFO - 'LOGNAME': 'cltbld', 19:59:55 INFO - 'MAIL': '/var/mail/cltbld', 19:59:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:55 INFO - 'MOZ_NO_REMOTE': '1', 19:59:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:55 INFO - 'NO_EM_RESTART': '1', 19:59:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:55 INFO - 'PWD': '/builds/slave/test', 19:59:55 INFO - 'SHELL': '/bin/bash', 19:59:55 INFO - 'SHLVL': '1', 19:59:55 INFO - 'TERM': 'linux', 19:59:55 INFO - 'TMOUT': '86400', 19:59:55 INFO - 'USER': 'cltbld', 19:59:55 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 19:59:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:55 INFO - '_': '/tools/buildbot/bin/python'} 19:59:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:55 INFO - Downloading/unpacking blobuploader==1.2.4 19:59: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:59: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:59: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:59: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:59: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:59: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:59:57 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 19:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59: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:59: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:59: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:59: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:59: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:59: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:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 19:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59: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:59: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:59: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:59: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:59: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:59: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:59:57 INFO - Downloading docopt-0.6.1.tar.gz 19:59:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 19:59:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:58 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:58 INFO - Running setup.py install for blobuploader 19:59:58 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:58 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:58 INFO - Running setup.py install for requests 19:59:58 INFO - Running setup.py install for docopt 19:59:58 INFO - Successfully installed blobuploader requests docopt 19:59:58 INFO - Cleaning up... 19:59:58 INFO - Return code: 0 19:59:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 19:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:58 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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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:59:58 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:59:58 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:59:58 INFO - Using env: {'DISPLAY': ':0', 19:59:58 INFO - 'HOME': '/home/cltbld', 19:59:58 INFO - 'LANG': 'en_US.UTF-8', 19:59:58 INFO - 'LANGUAGE': 'en_US:en', 19:59:58 INFO - 'LOGNAME': 'cltbld', 19:59:58 INFO - 'MAIL': '/var/mail/cltbld', 19:59:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:58 INFO - 'MOZ_NO_REMOTE': '1', 19:59:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:58 INFO - 'NO_EM_RESTART': '1', 19:59:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:58 INFO - 'PWD': '/builds/slave/test', 19:59:58 INFO - 'SHELL': '/bin/bash', 19:59:58 INFO - 'SHLVL': '1', 19:59:58 INFO - 'TERM': 'linux', 19:59:58 INFO - 'TMOUT': '86400', 19:59:58 INFO - 'USER': 'cltbld', 19:59:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 19:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:58 INFO - '_': '/tools/buildbot/bin/python'} 19:59:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:58 INFO - Running setup.py (path:/tmp/pip-Vr_EYr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:58 INFO - Running setup.py (path:/tmp/pip-02zX_S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:59 INFO - Running setup.py (path:/tmp/pip-Z5Mm4f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:59 INFO - Running setup.py (path:/tmp/pip-Imfgnx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:59 INFO - Running setup.py (path:/tmp/pip-ZUsslB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:59 INFO - Running setup.py (path:/tmp/pip-9bUAnm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:59 INFO - Running setup.py (path:/tmp/pip-jTMBTY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:59 INFO - Running setup.py (path:/tmp/pip-Q_U2aM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:59 INFO - Running setup.py (path:/tmp/pip-NqStD1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:59 INFO - Running setup.py (path:/tmp/pip-ReEFBZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:59 INFO - Running setup.py (path:/tmp/pip-dvCLqn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:59 INFO - Running setup.py (path:/tmp/pip-CEkHie-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:59 INFO - Running setup.py (path:/tmp/pip-8PsNFk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:59 INFO - Running setup.py (path:/tmp/pip-N6UXKO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:59 INFO - Running setup.py (path:/tmp/pip-gpwJGt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:59 INFO - Running setup.py (path:/tmp/pip-OuPiXF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:00 INFO - Running setup.py (path:/tmp/pip-Nj2_4V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:00 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:00:00 INFO - Running setup.py install for manifestparser 20:00:00 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Running setup.py install for mozcrash 20:00:00 INFO - Running setup.py install for mozdebug 20:00:00 INFO - Running setup.py install for mozdevice 20:00:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Running setup.py install for mozfile 20:00:00 INFO - Running setup.py install for mozhttpd 20:00:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Running setup.py install for mozinfo 20:00:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Running setup.py install for mozInstall 20:00:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:00:00 INFO - Running setup.py install for mozleak 20:00:00 INFO - Running setup.py install for mozlog 20:00:01 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Running setup.py install for moznetwork 20:00:01 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Running setup.py install for mozprocess 20:00:01 INFO - Running setup.py install for mozprofile 20:00:01 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Running setup.py install for mozrunner 20:00:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Running setup.py install for mozscreenshot 20:00:01 INFO - Running setup.py install for moztest 20:00:01 INFO - Running setup.py install for mozversion 20:00:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:00:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:00:01 INFO - Cleaning up... 20:00:01 INFO - Return code: 0 20:00:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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 20:00:01 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 20:00:01 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 20:00:01 INFO - Using env: {'DISPLAY': ':0', 20:00:01 INFO - 'HOME': '/home/cltbld', 20:00:01 INFO - 'LANG': 'en_US.UTF-8', 20:00:01 INFO - 'LANGUAGE': 'en_US:en', 20:00:01 INFO - 'LOGNAME': 'cltbld', 20:00:01 INFO - 'MAIL': '/var/mail/cltbld', 20:00:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:01 INFO - 'MOZ_NO_REMOTE': '1', 20:00:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:01 INFO - 'NO_EM_RESTART': '1', 20:00:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:01 INFO - 'PWD': '/builds/slave/test', 20:00:01 INFO - 'SHELL': '/bin/bash', 20:00:01 INFO - 'SHLVL': '1', 20:00:01 INFO - 'TERM': 'linux', 20:00:01 INFO - 'TMOUT': '86400', 20:00:01 INFO - 'USER': 'cltbld', 20:00:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 20:00:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:01 INFO - '_': '/tools/buildbot/bin/python'} 20:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:00:02 INFO - Running setup.py (path:/tmp/pip-rNG3nK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:00:02 INFO - Running setup.py (path:/tmp/pip-_ihrtN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:00:02 INFO - Running setup.py (path:/tmp/pip-KccdEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:00:02 INFO - Running setup.py (path:/tmp/pip-o37vAA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:00:02 INFO - Running setup.py (path:/tmp/pip-Atnogs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:00:02 INFO - Running setup.py (path:/tmp/pip-UYQTwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:00:02 INFO - Running setup.py (path:/tmp/pip-L_SGMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:00:02 INFO - Running setup.py (path:/tmp/pip-cmbtNq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:00:02 INFO - Running setup.py (path:/tmp/pip-Pm3LPY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:00:02 INFO - Running setup.py (path:/tmp/pip-C1TWSc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:00:02 INFO - Running setup.py (path:/tmp/pip-GmI47B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:00:02 INFO - Running setup.py (path:/tmp/pip-S00SBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:02 INFO - Running setup.py (path:/tmp/pip-B1MwAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:02 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)) 20:00:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:02 INFO - Running setup.py (path:/tmp/pip-HPs5nY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:03 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)) 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:03 INFO - Running setup.py (path:/tmp/pip-3xAeSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:03 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)) 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:03 INFO - Running setup.py (path:/tmp/pip-VOqCIA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:03 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)) 20:00:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:03 INFO - Running setup.py (path:/tmp/pip-xj_xDj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:03 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)) 20:00:03 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)) 20:00:03 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)) 20:00:03 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)) 20:00:03 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)) 20:00:03 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)) 20:00:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:04 INFO - Downloading blessings-1.5.1.tar.gz 20:00:04 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 20:00:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:05 INFO - Installing collected packages: blessings 20:00:05 INFO - Running setup.py install for blessings 20:00:05 INFO - Successfully installed blessings 20:00:05 INFO - Cleaning up... 20:00:05 INFO - Return code: 0 20:00:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:00:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:05 INFO - Reading from file tmpfile_stdout 20:00:05 INFO - Current package versions: 20:00:05 INFO - argparse == 1.2.1 20:00:05 INFO - blessings == 1.5.1 20:00:05 INFO - blobuploader == 1.2.4 20:00:05 INFO - docopt == 0.6.1 20:00:05 INFO - manifestparser == 1.1 20:00:05 INFO - mozInstall == 1.12 20:00:05 INFO - mozcrash == 0.16 20:00:05 INFO - mozdebug == 0.1 20:00:05 INFO - mozdevice == 0.47 20:00:05 INFO - mozfile == 1.2 20:00:05 INFO - mozhttpd == 0.7 20:00:05 INFO - mozinfo == 0.9 20:00:05 INFO - mozleak == 0.1 20:00:05 INFO - mozlog == 3.1 20:00:05 INFO - moznetwork == 0.27 20:00:05 INFO - mozprocess == 0.22 20:00:05 INFO - mozprofile == 0.27 20:00:05 INFO - mozrunner == 6.11 20:00:05 INFO - mozscreenshot == 0.1 20:00:05 INFO - mozsystemmonitor == 0.0 20:00:05 INFO - moztest == 0.7 20:00:05 INFO - mozversion == 1.4 20:00:05 INFO - psutil == 3.1.1 20:00:05 INFO - requests == 1.2.3 20:00:05 INFO - wsgiref == 0.1.2 20:00:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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 20:00:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 20:00:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 20:00:05 INFO - Using env: {'DISPLAY': ':0', 20:00:05 INFO - 'HOME': '/home/cltbld', 20:00:05 INFO - 'LANG': 'en_US.UTF-8', 20:00:05 INFO - 'LANGUAGE': 'en_US:en', 20:00:05 INFO - 'LOGNAME': 'cltbld', 20:00:05 INFO - 'MAIL': '/var/mail/cltbld', 20:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:05 INFO - 'MOZ_NO_REMOTE': '1', 20:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:05 INFO - 'NO_EM_RESTART': '1', 20:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:05 INFO - 'PWD': '/builds/slave/test', 20:00:05 INFO - 'SHELL': '/bin/bash', 20:00:05 INFO - 'SHLVL': '1', 20:00:05 INFO - 'TERM': 'linux', 20:00:05 INFO - 'TMOUT': '86400', 20:00:05 INFO - 'USER': 'cltbld', 20:00:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 20:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:05 INFO - '_': '/tools/buildbot/bin/python'} 20:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00:05 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)) 20:00: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.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 20:00:05 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)) 20:00:05 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)) 20:00:05 INFO - Cleaning up... 20:00:05 INFO - Return code: 0 20:00:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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 20:00:05 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 20:00:05 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 20:00:05 INFO - Using env: {'DISPLAY': ':0', 20:00:05 INFO - 'HOME': '/home/cltbld', 20:00:05 INFO - 'LANG': 'en_US.UTF-8', 20:00:05 INFO - 'LANGUAGE': 'en_US:en', 20:00:05 INFO - 'LOGNAME': 'cltbld', 20:00:05 INFO - 'MAIL': '/var/mail/cltbld', 20:00:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:05 INFO - 'MOZ_NO_REMOTE': '1', 20:00:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:05 INFO - 'NO_EM_RESTART': '1', 20:00:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:05 INFO - 'PWD': '/builds/slave/test', 20:00:05 INFO - 'SHELL': '/bin/bash', 20:00:05 INFO - 'SHLVL': '1', 20:00:05 INFO - 'TERM': 'linux', 20:00:05 INFO - 'TMOUT': '86400', 20:00:05 INFO - 'USER': 'cltbld', 20:00:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 20:00:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:05 INFO - '_': '/tools/buildbot/bin/python'} 20:00:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:05 INFO - Downloading/unpacking jsonschema 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:00:07 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 20:00:07 INFO - Downloading/unpacking functools32 (from jsonschema) 20:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:07 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 20:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:07 INFO - warning: no files found matching '*.txt' 20:00:07 INFO - no previously-included directories found matching 'build' 20:00:07 INFO - no previously-included directories found matching 'dist' 20:00:07 INFO - no previously-included directories found matching '.git*' 20:00:07 INFO - Installing collected packages: jsonschema, functools32 20:00:07 INFO - Running setup.py install for functools32 20:00:07 INFO - warning: no files found matching '*.txt' 20:00:07 INFO - no previously-included directories found matching 'build' 20:00:07 INFO - no previously-included directories found matching 'dist' 20:00:07 INFO - no previously-included directories found matching '.git*' 20:00:07 INFO - Successfully installed jsonschema functools32 20:00:07 INFO - Cleaning up... 20:00:07 INFO - Return code: 0 20:00:07 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 20:00: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')]} 20:00:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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')]} 20:00:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2584e42f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aaf8a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b7d240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, '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': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', '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 20:00: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', 'flake8'] in /builds/slave/test/build 20:00: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 flake8 20:00:07 INFO - Using env: {'DISPLAY': ':0', 20:00:07 INFO - 'HOME': '/home/cltbld', 20:00:07 INFO - 'LANG': 'en_US.UTF-8', 20:00:07 INFO - 'LANGUAGE': 'en_US:en', 20:00:07 INFO - 'LOGNAME': 'cltbld', 20:00:07 INFO - 'MAIL': '/var/mail/cltbld', 20:00:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:07 INFO - 'MOZ_NO_REMOTE': '1', 20:00:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:07 INFO - 'NO_EM_RESTART': '1', 20:00:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:07 INFO - 'PWD': '/builds/slave/test', 20:00:07 INFO - 'SHELL': '/bin/bash', 20:00:07 INFO - 'SHLVL': '1', 20:00:07 INFO - 'TERM': 'linux', 20:00:07 INFO - 'TMOUT': '86400', 20:00:07 INFO - 'USER': 'cltbld', 20:00:07 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 20:00:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:07 INFO - '_': '/tools/buildbot/bin/python'} 20:00:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:08 INFO - Downloading/unpacking flake8 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:09 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 20:00:09 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 20:00:09 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:10 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 20:00:10 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 20:00:10 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:10 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 20:00:10 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00: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 20:00:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:00:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:10 INFO - no previously-included directories found matching 'docs/_build' 20:00:10 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:00:10 INFO - Running setup.py install for pep8 20:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:10 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:10 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:10 INFO - no previously-included directories found matching 'docs/_build' 20:00:10 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:00:10 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:00:10 INFO - Cleaning up... 20:00:10 INFO - Return code: 0 20:00:10 INFO - Running post-action listener: _resource_record_post_action 20:00:10 INFO - Running post-action listener: _start_resource_monitoring 20:00:10 INFO - Starting resource monitoring. 20:00:10 INFO - ##### 20:00:10 INFO - ##### Running install step. 20:00:10 INFO - ##### 20:00:10 INFO - Running pre-action listener: _resource_record_pre_action 20:00:10 INFO - Running main action method: install 20:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:10 INFO - Reading from file tmpfile_stdout 20:00:10 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:11 INFO - Reading from file tmpfile_stdout 20:00:11 INFO - Output received: 20:00:11 INFO - Usage: mozinstall [options] installer 20:00:11 INFO - Options: 20:00:11 INFO - -h, --help show this help message and exit 20:00:11 INFO - -d DEST, --destination=DEST 20:00:11 INFO - Directory to install application into. [default: 20:00:11 INFO - "/builds/slave/test"] 20:00:11 INFO - --app=APP Application being installed. [default: firefox] 20:00:11 INFO - mkdir: /builds/slave/test/build/application 20:00:11 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'] 20:00:11 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 20:00:25 INFO - Reading from file tmpfile_stdout 20:00:25 INFO - Output received: 20:00:25 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:25 INFO - Running post-action listener: _resource_record_post_action 20:00:25 INFO - ##### 20:00:25 INFO - ##### Running run-tests step. 20:00:25 INFO - ##### 20:00:25 INFO - Running pre-action listener: _resource_record_pre_action 20:00:25 INFO - Running main action method: run_tests 20:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:25 INFO - Python 2.7.3 20:00:25 INFO - Return code: 0 20:00:25 INFO - grabbing minidump binary from tooltool 20:00:25 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')]} 20:00:25 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 0x2c0c0b0>, '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 0x2c0cfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2c0d440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:25 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 20:00:25 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 20:00:25 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:25 INFO - Return code: 0 20:00:25 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:00:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:00:26 INFO - Return code: 0 20:00:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 20:00:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 20:00:26 INFO - Using env: {'DISPLAY': ':0', 20:00:26 INFO - 'HOME': '/home/cltbld', 20:00:26 INFO - 'LANG': 'en_US.UTF-8', 20:00:26 INFO - 'LANGUAGE': 'en_US:en', 20:00:26 INFO - 'LOGNAME': 'cltbld', 20:00:26 INFO - 'MAIL': '/var/mail/cltbld', 20:00:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:26 INFO - 'MOZ_NO_REMOTE': '1', 20:00:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:26 INFO - 'NO_EM_RESTART': '1', 20:00:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:26 INFO - 'PWD': '/builds/slave/test', 20:00:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:26 INFO - 'SHELL': '/bin/bash', 20:00:26 INFO - 'SHLVL': '1', 20:00:26 INFO - 'TERM': 'linux', 20:00:26 INFO - 'TMOUT': '86400', 20:00:26 INFO - 'USER': 'cltbld', 20:00:26 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391', 20:00:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:26 INFO - '_': '/tools/buildbot/bin/python'} 20:00:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 20:00:26 INFO - mozversion INFO | application_buildid: 20151207183825 20:00:26 INFO - mozversion INFO | application_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 20:00:26 INFO - mozversion INFO | application_display_name: Nightly 20:00:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:26 INFO - mozversion INFO | application_name: Firefox 20:00:26 INFO - mozversion INFO | application_remotingname: firefox 20:00:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:00:26 INFO - mozversion INFO | application_vendor: Mozilla 20:00:26 INFO - mozversion INFO | application_version: 45.0a1 20:00:26 INFO - mozversion INFO | platform_buildid: 20151207183825 20:00:26 INFO - mozversion INFO | platform_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 20:00:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:26 INFO - mozversion INFO | platform_version: 45.0a1 20:00:26 INFO - 2015-12-07 20:00:26,805 DEBUG : using testdate: 1449547226 20:00:26 INFO - 2015-12-07 20:00:26,805 DEBUG : actual date: 1449547226 20:00:26 INFO - 2015-12-07 20:00:26,813 INFO : starting webserver on 'localhost:34615' 20:00:26 INFO - 2015-12-07 20:00:26,815 INFO : Starting test suite talos-linux64-ix-047 20:00:26 INFO - 2015-12-07 20:00:26,815 INFO : Starting test dromaeo_css 20:00:26 INFO - 2015-12-07 20:00:26,815 DEBUG : operating with platform_type : linux_ 20:00:26 INFO - 2015-12-07 20:00:26,815 INFO : Initialising browser for dromaeo_css test... 20:00:26 INFO - 2015-12-07 20:00:26,830 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXeprS/profile http://localhost:34615/getInfo.html 20:00:31 INFO - 2015-12-07 20:00:31,355 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:00:31 INFO - 2015-12-07 20:00:31,355 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:00:31 INFO - 2015-12-07 20:00:31,355 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:00:31 INFO - 2015-12-07 20:00:31,355 DEBUG : BROWSER_OUTPUT: __metrics 20:00:31 INFO - 2015-12-07 20:00:31,439 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:00:31 INFO - 2015-12-07 20:00:31,501 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:00:32 INFO - 2015-12-07 20:00:32,350 INFO : Browser initialized. 20:00:32 INFO - 2015-12-07 20:00:32,350 INFO : Running cycle 1/1 for dromaeo_css test... 20:00:32 INFO - 2015-12-07 20:00:32,350 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpXXeprS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:00:44 INFO - 2015-12-07 20:00:44,319 DEBUG : BROWSER_OUTPUT: RSS: Main: 142823424 20:00:44 INFO - 2015-12-07 20:00:44,319 DEBUG : BROWSER_OUTPUT: 20:01:35 INFO - 2015-12-07 20:01:35,428 DEBUG : BROWSER_OUTPUT: 1449547295424 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] 20:03:47 INFO - 2015-12-07 20:03:47,659 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:34615/tests/dromaeo/cssquery-ext.html) 20:03:48 INFO - 2015-12-07 20:03:48,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 258519040 20:03:48 INFO - 2015-12-07 20:03:48,805 DEBUG : BROWSER_OUTPUT: 20:06:51 INFO - 2015-12-07 20:06:51,247 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-ext.html (next: http://localhost:34615/tests/dromaeo/cssquery-jquery.html) 20:06:51 INFO - 2015-12-07 20:06:51,841 DEBUG : BROWSER_OUTPUT: RSS: Main: 220622848 20:06:51 INFO - 2015-12-07 20:06:51,841 DEBUG : BROWSER_OUTPUT: 20:09:53 INFO - 2015-12-07 20:09:53,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:34615/tests/dromaeo/cssquery-mootools.html) 20:09:54 INFO - 2015-12-07 20:09:54,409 DEBUG : BROWSER_OUTPUT: RSS: Main: 227213312 20:09:54 INFO - 2015-12-07 20:09:54,409 DEBUG : BROWSER_OUTPUT: 20:12:56 INFO - 2015-12-07 20:12:56,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:34615/tests/dromaeo/cssquery-prototype.html) 20:12:56 INFO - 2015-12-07 20:12:56,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 203755520 20:12:56 INFO - 2015-12-07 20:12:56,881 DEBUG : BROWSER_OUTPUT: 20:15:59 INFO - 2015-12-07 20:15:59,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:34615/tests/dromaeo/cssquery-yui.html) 20:16:00 INFO - 2015-12-07 20:16:00,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 207712256 20:16:00 INFO - 2015-12-07 20:16:00,235 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,674 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/dromaeo/cssquery-yui.html (next: http://localhost:34615/tests/dromaeo/cssquery-dojo.html) 20:19:02 INFO - 2015-12-07 20:19:02,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 263639040 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:19:02 INFO - 2015-12-07 20:19:02,925 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2593.14426239341;2717.266338088716;2721.5509440942246;2733.822301550399;2737.2062101990423;4496.865094047183;4640.3967484227005;4733;4734.597559207467;4750.121227572897;4598.356230127785;4659.207934651109;4670.042641258542;4769.284607308906;4770.4275486941615;4277.550857160008;4350.260455722519;4361.760103194323;4371.27873900806;4448.065906159694;4327.350897365389;4370.562943705636;4377.562243775629;4406.5373135820755;4436.778161091933;4124.52567954683;4231.365295205713;4377.430933978594;4424.960134368421;4434.201843668138;4280.507741609693;4284.764337961411;4295.785210739482;4296.205202037633;4299.699021068526;4227.196832601796;4230.069384735353;4232.640225580829;4235.216484950294;4241.4698162729655;4566.40636717228;4575.6568257380495;4637.536246375335;4657.860264192046;4674.32222327764;5060.898782024376;5090.745462726849;5095.719735414587;5134.7689353978785;5138.152204886189;4793.880152996168;4896.926546101811;5080.060188865072;5091.287219789232;5103.2855400244;4559.77201139945;4598.080383923195;4692.436907571113;4695.671303008825;4734.621230301567;5116.155834287375;5154.871128221749;5166.302549155891;5171.482851714798;5210.348706411699;4689.718616882998;4808.110499557593;4981.12830254704;4981.701097934136;4983.327250821165;4877.170880950247;4932.210846264652;4961.776720047606;4970.304157417964;4978.0292842896015;4963.6277279204205;4968.031233909425;4968.826091086795;4974.801007959641;5006.599472042228;4950.108980383566;4952.603791696655;4956.529129732669;4965.627577931669;5000.874978125503;4041.3533834586915;4127.7936103194725;4131.380292956081;4202.138561594866;4312.676549258818;3722.3113723960614;3725.739198256096;3732.5147730794824;3756.4553139795125;3763.4354846773203;4319.762413067311;4322.416473776063;4323.135372925428;4324.827006919751;4360.4331436913;4829.251466022772;4940.987097644974;4941.407031156213;4956.826511072095;5075.3402057733;4308.655307575386;4341.175176716414;4343.326784348431;4350.521442641307;4371.584699453547;4526.88682782933;4547.613452856478;4549.522300158435;4551.112533056088;4585.541445855388;4535.342375355621;4646.488886222581;4650.720956742674;4700.976495117503;4789.3055506952;4925.813656668771;4930.901381972269;4936.481669424802;4945.455999839943;4993.425756038102;4736.881577960578;4738.763061846963;4747;4749.05018996209;4790.880227994328;4795.304680821192;4839.975800120977;4881.51184881509;4915.066137433876;4937.728424936663;5013.2981382607195;5088;5090.312807770903;5115.1559992600805;5137.049645815536;4870.756462176806;4913.434954980223;4913.975430122827;4915.483874193301;4965.981973695311;4615.769211539342;4719.315699223662;4719.905601888012;4777.665563410528;4913.950860491349;4748.3827102477835;4794.520547945178;4795.784189711401;4808.110499557593;4825.30033145199;4938.407391113089;4940.950590494049;4945.18404463274;4952.083864484937;4990.476000019946;4648.558386953234;4715.740634265148;4773.737444440589;4778.307145463818;4831.227003679394 20:19:02 INFO - 2015-12-07 20:19:02,927 DEBUG : BROWSER_OUTPUT: |1;ext.html;534.3854567247664;542.224618795123;542.7855996881232;570.7289037707087;571.8284514645603;25051.874740626296;34783.652163478386;35457.46813797795;35479.2904141917;35500.46749298763;39917.40123898144;39981.40027899584;40435.59564404355;40511.59488405115;40523.59476405235;6989.05647737554;7114.786556403316;7890.8816367754525;8051.154628763983;8067.9193208068045;10199.23505737069;10440.895591044105;10441.112505437048;10442.843357349646;10456.529456174452;10108.342957707762;10210.744731381701;10211.642592509264;10213.182945364353;10224.130948869319;7232.674529646152;7388.667509962064;10029.24780641451;10087.798244035079;10313.226508011929;9977.201823854075;10143.18854491639;10149.086582207563;10149.949250253776;10151.340162889388;36991.260174796626;37298.44052339217;37491.81254093712;37548.49418069849;37585.62414375848;2730.9044183453484;2749.340158361999;2846.9145925622265;3064.846757662108;3100.4264211121017;26364.86817565919;26382;26829.19512414611;26936.461270774475;27632.171034868785;3415.0995905060936;3421.2815308785184;3441.1397150712323;3469.8785542505893;3546.343926373629;221071;221737;221794;221922;223541.99999999837;51014.48985510172;55468;55934.72032639892;55935;56017.439825602036;46367.76816115898;46530.767346163055;46599;46660;64668.676656616415;12824.615261542169;13249.668758280928;13333.866661333263;13359.398827052806;13371.264580447974;9895.65365212214;9922.107010368956;9923.1069203772;9982.750431239132;9985.750356241153;18797.342093026953;18962.62074758497;18973.620527589646;18977;18998.525036874187;7475.43934204926;7699.692012319444;7823.748200287927;7848.725294614661;7897.565633890191;825.8719898415756;891.777055736066;901.4771432569225;977.0376179463223;996.2776986684596;25877.74122258791;25979.22062338133;26467.338316541856;26481;26532.8673356632;964.1659964130977;975.9609615615437;976.6532880827347;1034.7723500829804;1040.7554224757175;13686.65783355424;13747.38136783847;14103.576892693236;14129.434822606981;14156.716865662835;261896;266284;266735;266778;267416;44988.10023799571;45113;45236.77381613137;45269.32096018562;45287.547124528995;1185.2264309471411;1196.491491116272;1204.1691233049344;1206.4993027893502;1215.2890559022894;25061.49877002486;25116;26212.344691382867;26235.86882065654;26240.73759262383;40354.59645403508;40753.1849363017;40782;40803;40809.38785918273;228420;233148;241660;249784;255996;24873.253802385956;24906.63013534273;24939.750602494467;24940.625890612017;25265.494690105726;32217.677823221467;32287.192820179684;33205.83397083096;33231;38417.61582384252;28822.855885720437;29090;29232.707672923;29737;29744.10767676973;28699.713002869703;28895.133146005654;28905.42189156163;29074.27314317159;29126.41747165087;31914.52128218125;32161.195970100936;32476.025719228463;32551.67448325581;32640.510392344608;27702.44595108127;28101.297467563476;29955.400891981604;30238.54642180413;30343.544846827757;22777.31668049961;22885.199018034287;23172.652410214196;23278.418039549146;23281 20:19:02 INFO - 2015-12-07 20:19:02,930 DEBUG : BROWSER_OUTPUT: |2;jquery.html;284.9615301934241;286.13159062246086;286.3899893227425;287.3176206509541;291.8234468146772;13194.274314912676;13653.795193072112;15165.317560709767;15578.610534736637;15582.142982135992;12277.75444491112;13256.40346184424;13467.865321346784;13573.728525429486;13602.047856650039;4125.608067233608;4236.894077648052;4376.474823021242;4490.685652004361;4491.124230775;4414.558544145591;4442.888927776815;4450.666200034994;4450.910981780363;4451.198784218839;4440.644748420119;4451.1542806866755;4452.10957808438;4453.332000199964;4531.864044078683;4402.207602631525;4498.617617502517;4500.932486012696;4503.347014682852;4505.234110201257;4363.759993200372;4366;4368.825246990116;4371.628411585019;4372.234858899712;10530.210234232463;10661.253712240146;10667.573297068107;10675.626353077683;11241.494132764044;1735.0977491704368;1770.6635739209637;1798.6043070524463;1826.4155470249525;1891.6878715012006;8177.713780017671;8192.385571082134;8233.3824963128;8562.614682339248;8681.869771953427;1723.0271339316537;1750.439859245042;1757.182909946868;1772.8493078088377;1774.6805574996495;55701.16448253239;57971.420285797445;58421.41578584202;58624;59588.40411595915;9470.95264523673;9636.22910167185;9698;9711.465869377253;9775.706728798148;10742.624008159677;10744.247902646739;11037.83443248352;12237.20458170216;12277.386130693609;5007.324011258506;5121.769520371592;5253.737313134328;6833.726650933907;6843.965780171067;6166.691665416712;6174.073888916609;6226.968865155645;6227.9377206227355;6250.937490625036;4025.5370632377067;4029.1538776857187;4045.3931910213705;4090.570490098556;4096.938545921814;1647.571631375851;1698.7112190927571;1723.7931448226293;1728.7752592162938;1735.5747841778846;335.92441700617167;336.8534687410935;853.799357151069;881.6737807011318;975.9463229522445;15267.160306183045;16641.334346625998;16924;17303.74044389335;17310.82689173092;817.5912043978011;817.652497688492;848.6053984897053;855.8331125430482;916.6562539047857;8670.393072484992;8903.821923561492;9441.150296473214;9624.37441566296;9630.807383852283;485062;486714;493690;495602;496041;69443;71714.64142679253;72739;74499;74721;1085.913126949858;1087.7552550676035;1111.1943840715578;1136.2046567402851;1136.471540733563;14410.567682969528;14696.55910322692;15095.245237738289;15266.618334541725;15360.692786144438;23728.644070339305;33166.00501984944;33276.66723332736;33452.49821252634;34961;39604;40943.590564093975;40971.1805763889;41511;42491.57508424876;8612.354073444641;8677;8802.25180859634;8865.246454051477;8866.866996995179;11911.463984120563;11997.700057498632;13726.65683357924;16086.034837909294;16225.918870406045;13620.114692544952;13653.522126725517;13913.72172556523;14108.717825643635;14175.929120354333;13400.597982060553;13549.525766598123;13731.725365492435;13942.721145577234;14166.78749818733;13294.534691285759;13319.86680133225;13649.181049137083;13770;14110.647233819236;8862.113788621085;8902.421342612968;8931.240844528287;8940.642374305215;8942.150495702897;13545.32273386307;13831.446742130202;13850.58448246514;14081;14155.716885662436 20:19:02 INFO - 2015-12-07 20:19:02,931 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1323.8080478330642;1366.1325058587793;1402.7475054490187;1582.185174635063;1664.4091347571616;5941.613795103321;6814.62519561424;6911.481638877091;6934.8266293342695;6942.895856562156;6867.141607299088;7062.046623705798;7069.116360454943;7069.964650176755;7075.46933979951;2040.2451093095538;2072.202202152175;2074.4295318787304;2077.6156411064003;2079.2514694709894;2043.1520918818671;2079.979200208001;2086.7287252657134;2102.211670623516;2106.2522804404443;1987.155458929949;2010.9497262568407;2031.451508092814;2033.8677985930867;2035.6132334856404;1981.375866602023;2001.959960800776;2005.5587770690497;2006.7190593316948;2013.8791672499624;1988.3239698502434;2004.0881398963581;2039.3576023552534;2041.9183232670675;2044.9079791409422;6937.7571784987285;7049;7053.470989675795;7056.082709247765;7093.467989900726;4045.4538637283886;4091.40674602184;4104;4123.9175216495505;4125.071858831769;2579.57437022891;2612.7909767218575;2613.5556955317643;2628.8028397870235;2651.0853755454336;826.1655727715051;847.3560094328293;847.720252316734;851.6082602003086;1741.9912900435543;9330.533473326375;9411.717648470556;9433.386829855968;9443.244540436748;9483.099105584959;3552.0764601203873;3554.4845997330244;3599.478075679064;3627.3289441453417;3664.0839790052487;7418.072740907387;7428.257174282637;7433.368163706145;7443.292887175709;7489.737859174903;4039.4546736190828;4044.3933409988736;4054.8378064877074;4059.512858457004;4063.0858056937545;3027.606411166534;3044.3150291184747;3641.417373220272;3728.3289007978824;3732.0856390184576;3093.3503964167326;3167.509036099362;3180.9522857157162;3187.665295144023;3199.328141090397;885.7874110213502;909.2952961454926;918.7611221082567;921.6037104045325;924.6948506992676;858.1932982995963;879.9836189201483;1151.7638884028754;1161.5586077290575;1167.6847251242118;6553.672316384162;6568.7372505099265;6604.8348791280605;6618.867622647616;6654.201495820435;1006.3659894266565;1025.3489034463169;1029.161233594633;1033.3180101133216;1050.76883085721;5175.249588809602;5206.505381988705;5211.635185537052;5215;5217.556507696812;8116.188381161955;8116.228958248957;8128.715494957648;8190.50856948585;8358.958205209057;8263.049749278789;8335.749927502186;8349.165083491602;8367.874481882776;8377.2460478556;6518.837029074311;6526.706298216592;6570.605763654196;6626.768063117865;6668.499862510331;6618;6668.899966500409;6673.666316684244;6676.232233293234;6682.46540276767;7527.435442341955;7541.660625271767;7559.508631938907;7566.167721550515;7666.156722760604;7663.693452261847;7716.652750626347;7841.059072911287;7874.685012599661;7886.132525422314;5137.357830271216;5248.580113590827;5960.135780311917;6030.276366836008;6055.122007308827;6423.229212494531;6550.901736474052;6585.736570537125;6588.472922166311;6594.868102637824;6135.877282454237;6177.752889884354;6272.780452684134;6282.968585157228;6378.851806674843;6135.539834512519;6207.782727604512;6278.246610406781;6286.277078136073;6348.047792831112;6179.783707570214;6194.38056194377;6198.845028874314;6199.535034872493;6212.875742485035;5858.8242352729485;5877.23595932526;5880.882382352243;5886.911696324644;5895.852603684943;5778.739956701875;5812.534997200299;5878;5885.646861188342;5887.381824908494 20:19:02 INFO - 2015-12-07 20:19:02,933 DEBUG : BROWSER_OUTPUT: |4;prototype.html;251.7117900004495;255.69572209071208;260.39198471568886;260.67025213105427;262.1832990235417;5295.152775555912;5368.597355198366;5385.892282154355;5388.353397592285;5388.973055134724;5082.542571168594;5157.7936882524655;5252.8161514347;5255.684658920468;5258.1849813278905;3996.780177090259;3997.3804060370544;3997.4403583498333;3998.920021599566;4000.919981600366;4002.379631157161;4003.219372222418;4005.038790690228;4005.2790497710403;4016;3952.26883026641;3955.189186216833;3955.3275943089743;3955.920881582381;3958.2083583283315;3866.168773713665;3945.960540394588;3950.4469374287623;3960.7029472789513;3962.346212874872;3403.9659603403898;3406.318736252759;3407.9488807667904;3409.1817963688786;3419.042668052949;5148.871278218037;5161.61287903405;5167.147420675584;5167.276581278624;5170.663906846043;4562.520935301812;4564.931526027112;4566.885827854297;4569.794359253809;4572.497025327211;5593;5599.412061733541;5606.775728970836;5615.494605485526;5617.606767526275;3594.0116467971256;3694.685951694082;3696.537932758405;3704.555453345589;3708.9443658344876;5708.372079071299;5812.273465816773;5861.3552509223955;5959.523238140939;5962.522998160137;3676.0258531489176;3685.7972811495624;3688.133288677159;3688.944665830015;3691.7784932903573;3733.0853940784136;3825.598312177237;3847.076701591598;3848.7690738555775;3851.0372406898277;4524.751138687404;4545.795439205243;4551.567601077959;4555.931661025087;4557.384753058361;5389.7035663038905;5423.918641220384;5552.888942221133;5657.462541058593;5665.716714164275;1284.0818814547642;1351.3851197705021;1353.3706826325806;1356.3082827757717;1356.6947436826636;863.6545381847186;870.6909047288121;882.633707011583;885.2121611765534;889.857622780365;4947.134251505972;4957.3307603473795;4963.851084467472;4968.677035992649;4968.701877887338;5898.469137777534;5907.940920590825;5909.409059094142;5911.40885911414;5912.70436478183;4950.579200767975;4952.108620448282;4961.08219979305;4962.478939711278;4966.056449274626;3093.072078376478;3158.2578094147857;3187.2031992002;3187.936241275208;3192.409404260219;5555.361133469622;5624.606277560613;5628.296462942132;5631.943680563224;5634.661920284714;6101;6102.816915492543;6118.296395914438;6127.908081378783;6140.631562106288;5612.635178713371;5626.578006649518;5631.18347839561;5633.436656334252;5640;5790.247267855152;5973.910391344047;5974.283086029531;5980.790672326448;5987.820365389045;5832.883342333214;5837.970810145922;5841.474267315962;5848.327442344185;5855.38518455556;5634.042212823748;5636.4927156556105;5639.436056394492;5639.689817060101;5642.181883626933;3547.9290414191055;3554.3246783111126;3666.7066634669695;3813.1420430402936;3863.188730366542;5762.827115186551;5799;5805.535557155333;5806.187133801187;5806.622569532967;5676.68778217202;5677.687727175045;5680.914786278292;5681.062624667049;5683.204351390891;5670.688112153871;5675.31896172462;5681.17622944679;5681.460261275172;5683.77264909399;5434.701091440009;5553.8333849984565;5557.083081291542;5558.416366281483;5564.165375193753;5693.9181555505975;5698.344690360662;5706.914396284142;5711.8857622848145;5714.228579141763;5576.10782274834;5577.135543990688;5587.078132108157;5587.1339942309005;5589.776408943597 20:19:02 INFO - 2015-12-07 20:19:02,936 DEBUG : BROWSER_OUTPUT: |5;yui.html;632.8545332947368;668.0680450771177;682.2972338491353;773.292437419761;781.4334607409629;12021.338826364547;12285.570005049825;12354.814677779841;12360.320182389976;12366;11287.15346349023;11764.588239411622;11766.176367654267;11772.99929505993;11843.881561184386;612.1246617337206;621.9985822825248;622.3185611755143;779.1273773373829;798.6446031515977;612.9785457508988;616.0420546050889;757.1708978668377;784.051297929506;786.0528063683248;811.7037281392279;818.1654712193559;821.7288294862681;824.6165533027141;824.68661908475;634.194572892424;818.1327792539897;818.6602559937619;818.8116733151379;818.9222023907719;476.67586041491774;603.4267445926343;615.602936106209;617.5677026081761;618.3229363846581;11683.357415342152;11742.88257117435;11799.115066370057;11828.940855295668;11838.408079596073;10296.536655850505;10866.45667716611;10894.455277236186;11028.22802403832;11131.220814542905;8556.101609331055;8991.235744961687;9044.8643270351;9221.308401869886;9390.107939745712;3220.033989803073;3272.4109660261142;3285.4414749492644;3287.063186991696;3358.9160270993175;38080.61919380799;38290.42564361537;38566.80716596399;38579.421308680394;38590.22819543621;9004.459732416077;9189.81620367589;9368.62525498986;9383.202427793714;9628.085331893459;14495.710085798224;14549.054311469721;14607.634809129644;14615.415383384758;14639.853601463848;6028.457438830526;6059.7273122709585;6150.323464418911;6223.96888015557;6241.656708881055;3597.6222496638;3619.9638003620153;3637.2361804021452;3664.3953747631344;3681.815909204529;2591.002464051354;2602.2843717977707;2609.4781043791318;2610.4909542639;2618.0967566189634;464.0695405711527;465.6344769356039;466.8902807840155;472.1454167956011;473.81284392665395;487.60747598183093;554.8474169603392;574.9252597162425;606.4269265544018;609.2840911928466;7336.633168341562;7802.921970780333;8002.7199048033035;8027.117017128111;8556.443831150955;493.19116648696166;567.6026781253139;587.5152998776027;612.124661733725;615.5967841064111;3371.005553361764;3374.4263475209273;3522.0842580929143;3549.94675079874;3661.377565813818;46474.76762616165;47199.292010619865;47423.76288118537;47629.52370476251;47714.76142619265;45760.855978600805;46016.30975535369;46753.766231169306;46805.76597117061;47475.28787068197;38490.23019539649;38656.22687546234;39203.803980979916;40016.19967600632;40041.39937900934;7664.195259497673;7860.5676687782725;7971.481853679492;8202.958985205036;8436.156384361515;28664.856675716488;29190.416191675624;29339;29646.703532964395;29877.253068673457;36722.63277367192;37304.44043339298;37777.81111094427;39155.804220978716;39194.53290207084;10051.899481005388;10184.439855808001;10238.795224095626;10316.587336506456;10462.738431539272;10138.442385668859;10478.685639430829;10561.841572376266;10733.463326833784;11062.612808551663;10593.841092383465;10713.517891695048;10776.622818201326;10792.190585705946;11528.250663706833;9574.569144388659;9609.615615375586;9704.660336888175;9744.464054477072;9752.317337786288;9740.805183896424;9846.704598862045;9862.753431164278;10045.799084018425;10124.139448146696;8632.482051076955;8770.295184663999;8778.473291602524;9087.136722011399;9167.266618670623;9150.313726470407;9203.35576509638;9204;9246.9537652314;9252.768680782765 20:19:02 INFO - 2015-12-07 20:19:02,936 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,975 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548342923__endTimestamp 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4622.23 Median:4736.88 stddev:471.92 (10.0%) stddev-sans-first:445.71 20:19:02 INFO - 2015-12-07 20:19:02,937 DEBUG : BROWSER_OUTPUT: Values: 2593.1 2717.3 2721.6 2733.8 2737.2 4496.9 4640.4 4733.0 4734.6 4750.1 4598.4 4659.2 4670.0 4769.3 4770.4 4277.6 4350.3 4361.8 4371.3 4448.1 4327.4 4370.6 4377.6 4406.5 4436.8 4124.5 4231.4 4377.4 4425.0 4434.2 4280.5 4284.8 4295.8 4296.2 4299.7 4227.2 4230.1 4232.6 4235.2 4241.5 4566.4 4575.7 4637.5 4657.9 4674.3 5060.9 5090.7 5095.7 5134.8 5138.2 4793.9 4896.9 5080.1 5091.3 5103.3 4559.8 4598.1 4692.4 4695.7 4734.6 5116.2 5154.9 5166.3 5171.5 5210.3 4689.7 4808.1 4981.1 4981.7 4983.3 4877.2 4932.2 4961.8 4970.3 4978.0 4963.6 4968.0 4968.8 4974.8 5006.6 4950.1 4952.6 4956.5 4965.6 5000.9 4041.4 4127.8 4131.4 4202.1 4312.7 3722.3 3725.7 3732.5 3756.5 3763.4 4319.8 4322.4 4323.1 4324.8 4360.4 4829.3 4941.0 4941.4 4956.8 5075.3 4308.7 4341.2 4343.3 4350.5 4371.6 4526.9 4547.6 4549.5 4551.1 4585.5 4535.3 4646.5 4650.7 4701.0 4789.3 4925.8 4930.9 4936.5 4945.5 4993.4 4736.9 4738.8 4747.0 4749.1 4790.9 4795.3 4840.0 4881.5 4915.1 4937.7 5013.3 5088.0 5090.3 5115.2 5137.0 4870.8 4913.4 4914.0 4915.5 4966.0 4615.8 4719.3 4719.9 4777.7 4914.0 4748.4 4794.5 4795.8 4808.1 4825.3 4938.4 4941.0 4945.2 4952.1 4990.5 4648.6 4715.7 4773.7 4778.3 4831.2 20:19:02 INFO - 2015-12-07 20:19:02,938 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,938 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39815.15 Median:29108.21 stddev:63474.08 (218.1%) stddev-sans-first:63583.62 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: Values: 534.4 542.2 542.8 570.7 571.8 25051.9 34783.7 35457.5 35479.3 35500.5 39917.4 39981.4 40435.6 40511.6 40523.6 6989.1 7114.8 7890.9 8051.2 8067.9 10199.2 10440.9 10441.1 10442.8 10456.5 10108.3 10210.7 10211.6 10213.2 10224.1 7232.7 7388.7 10029.2 10087.8 10313.2 9977.2 10143.2 10149.1 10149.9 10151.3 36991.3 37298.4 37491.8 37548.5 37585.6 2730.9 2749.3 2846.9 3064.8 3100.4 26364.9 26382.0 26829.2 26936.5 27632.2 3415.1 3421.3 3441.1 3469.9 3546.3 221071.0 221737.0 221794.0 221922.0 223542.0 51014.5 55468.0 55934.7 55935.0 56017.4 46367.8 46530.8 46599.0 46660.0 64668.7 12824.6 13249.7 13333.9 13359.4 13371.3 9895.7 9922.1 9923.1 9982.8 9985.8 18797.3 18962.6 18973.6 18977.0 18998.5 7475.4 7699.7 7823.7 7848.7 7897.6 825.9 891.8 901.5 977.0 996.3 25877.7 25979.2 26467.3 26481.0 26532.9 964.2 976.0 976.7 1034.8 1040.8 13686.7 13747.4 14103.6 14129.4 14156.7 261896.0 266284.0 266735.0 266778.0 267416.0 44988.1 45113.0 45236.8 45269.3 45287.5 1185.2 1196.5 1204.2 1206.5 1215.3 25061.5 25116.0 26212.3 26235.9 26240.7 40354.6 40753.2 40782.0 40803.0 40809.4 228420.0 233148.0 241660.0 249784.0 255996.0 24873.3 24906.6 24939.8 24940.6 25265.5 32217.7 32287.2 33205.8 33231.0 38417.6 28822.9 29090.0 29232.7 29737.0 29744.1 28699.7 28895.1 28905.4 29074.3 29126.4 31914.5 32161.2 32476.0 32551.7 32640.5 27702.4 28101.3 29955.4 30238.5 30343.5 22777.3 22885.2 23172.7 23278.4 23281.0 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26031.07 Median:4067.98 stddev:80360.82 (1975.4%) stddev-sans-first:80563.00 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: Values: 285.0 286.1 286.4 287.3 291.8 13194.3 13653.8 15165.3 15578.6 15582.1 12277.8 13256.4 13467.9 13573.7 13602.0 4125.6 4236.9 4376.5 4490.7 4491.1 4414.6 4442.9 4450.7 4450.9 4451.2 4440.6 4451.2 4452.1 4453.3 4531.9 4402.2 4498.6 4500.9 4503.3 4505.2 4363.8 4366.0 4368.8 4371.6 4372.2 10530.2 10661.3 10667.6 10675.6 11241.5 1735.1 1770.7 1798.6 1826.4 1891.7 8177.7 8192.4 8233.4 8562.6 8681.9 1723.0 1750.4 1757.2 1772.8 1774.7 55701.2 57971.4 58421.4 58624.0 59588.4 9471.0 9636.2 9698.0 9711.5 9775.7 10742.6 10744.2 11037.8 12237.2 12277.4 5007.3 5121.8 5253.7 6833.7 6844.0 6166.7 6174.1 6227.0 6227.9 6250.9 4025.5 4029.2 4045.4 4090.6 4096.9 1647.6 1698.7 1723.8 1728.8 1735.6 335.9 336.9 853.8 881.7 975.9 15267.2 16641.3 16924.0 17303.7 17310.8 817.6 817.7 848.6 855.8 916.7 8670.4 8903.8 9441.2 9624.4 9630.8 485062.0 486714.0 493690.0 495602.0 496041.0 69443.0 71714.6 72739.0 74499.0 74721.0 1085.9 1087.8 1111.2 1136.2 1136.5 14410.6 14696.6 15095.2 15266.6 15360.7 23728.6 33166.0 33276.7 33452.5 34961.0 39604.0 40943.6 40971.2 41511.0 42491.6 8612.4 8677.0 8802.3 8865.2 8866.9 11911.5 11997.7 13726.7 16086.0 16225.9 13620.1 13653.5 13913.7 14108.7 14175.9 13400.6 13549.5 13731.7 13942.7 14166.8 13294.5 13319.9 13649.2 13770.0 14110.6 8862.1 8902.4 8931.2 8940.6 8942.2 13545.3 13831.4 13850.6 14081.0 14155.7 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4830.05 Median:6135.71 stddev:2502.68 (40.8%) stddev-sans-first:2495.83 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: Values: 1323.8 1366.1 1402.7 1582.2 1664.4 5941.6 6814.6 6911.5 6934.8 6942.9 6867.1 7062.0 7069.1 7070.0 7075.5 2040.2 2072.2 2074.4 2077.6 2079.3 2043.2 2080.0 2086.7 2102.2 2106.3 1987.2 2010.9 2031.5 2033.9 2035.6 1981.4 2002.0 2005.6 2006.7 2013.9 1988.3 2004.1 2039.4 2041.9 2044.9 6937.8 7049.0 7053.5 7056.1 7093.5 4045.5 4091.4 4104.0 4123.9 4125.1 2579.6 2612.8 2613.6 2628.8 2651.1 826.2 847.4 847.7 851.6 1742.0 9330.5 9411.7 9433.4 9443.2 9483.1 3552.1 3554.5 3599.5 3627.3 3664.1 7418.1 7428.3 7433.4 7443.3 7489.7 4039.5 4044.4 4054.8 4059.5 4063.1 3027.6 3044.3 3641.4 3728.3 3732.1 3093.4 3167.5 3181.0 3187.7 3199.3 885.8 909.3 918.8 921.6 924.7 858.2 880.0 1151.8 1161.6 1167.7 6553.7 6568.7 6604.8 6618.9 6654.2 1006.4 1025.3 1029.2 1033.3 1050.8 5175.2 5206.5 5211.6 5215.0 5217.6 8116.2 8116.2 8128.7 8190.5 8359.0 8263.0 8335.7 8349.2 8367.9 8377.2 6518.8 6526.7 6570.6 6626.8 6668.5 6618.0 6668.9 6673.7 6676.2 6682.5 7527.4 7541.7 7559.5 7566.2 7666.2 7663.7 7716.7 7841.1 7874.7 7886.1 5137.4 5248.6 5960.1 6030.3 6055.1 6423.2 6550.9 6585.7 6588.5 6594.9 6135.9 6177.8 6272.8 6283.0 6378.9 6135.5 6207.8 6278.2 6286.3 6348.0 6179.8 6194.4 6198.8 6199.5 6212.9 5858.8 5877.2 5880.9 5886.9 5895.9 5778.7 5812.5 5878.0 5885.6 5887.4 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,939 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4618.38 Median:5331.88 stddev:1436.78 (26.9%) stddev-sans-first:1402.93 20:19:02 INFO - 2015-12-07 20:19:02,941 DEBUG : BROWSER_OUTPUT: Values: 251.7 255.7 260.4 260.7 262.2 5295.2 5368.6 5385.9 5388.4 5389.0 5082.5 5157.8 5252.8 5255.7 5258.2 3996.8 3997.4 3997.4 3998.9 4000.9 4002.4 4003.2 4005.0 4005.3 4016.0 3952.3 3955.2 3955.3 3955.9 3958.2 3866.2 3946.0 3950.4 3960.7 3962.3 3404.0 3406.3 3407.9 3409.2 3419.0 5148.9 5161.6 5167.1 5167.3 5170.7 4562.5 4564.9 4566.9 4569.8 4572.5 5593.0 5599.4 5606.8 5615.5 5617.6 3594.0 3694.7 3696.5 3704.6 3708.9 5708.4 5812.3 5861.4 5959.5 5962.5 3676.0 3685.8 3688.1 3688.9 3691.8 3733.1 3825.6 3847.1 3848.8 3851.0 4524.8 4545.8 4551.6 4555.9 4557.4 5389.7 5423.9 5552.9 5657.5 5665.7 1284.1 1351.4 1353.4 1356.3 1356.7 863.7 870.7 882.6 885.2 889.9 4947.1 4957.3 4963.9 4968.7 4968.7 5898.5 5907.9 5909.4 5911.4 5912.7 4950.6 4952.1 4961.1 4962.5 4966.1 3093.1 3158.3 3187.2 3187.9 3192.4 5555.4 5624.6 5628.3 5631.9 5634.7 6101.0 6102.8 6118.3 6127.9 6140.6 5612.6 5626.6 5631.2 5633.4 5640.0 5790.2 5973.9 5974.3 5980.8 5987.8 5832.9 5838.0 5841.5 5848.3 5855.4 5634.0 5636.5 5639.4 5639.7 5642.2 3547.9 3554.3 3666.7 3813.1 3863.2 5762.8 5799.0 5805.5 5806.2 5806.6 5676.7 5677.7 5680.9 5681.1 5683.2 5670.7 5675.3 5681.2 5681.5 5683.8 5434.7 5553.8 5557.1 5558.4 5564.2 5693.9 5698.3 5706.9 5711.9 5714.2 5576.1 5577.1 5587.1 5587.1 5589.8 20:19:02 INFO - 2015-12-07 20:19:02,941 DEBUG : BROWSER_OUTPUT: 20:19:02 INFO - 2015-12-07 20:19:02,941 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11914.53 Median:23835.72 stddev:13425.03 (56.3%) stddev-sans-first:13435.96 20:19:02 INFO - 2015-12-07 20:19:02,942 DEBUG : BROWSER_OUTPUT: Values: 632.9 668.1 682.3 773.3 781.4 12021.3 12285.6 12354.8 12360.3 12366.0 11287.2 11764.6 11766.2 11773.0 11843.9 612.1 622.0 622.3 779.1 798.6 613.0 616.0 757.2 784.1 786.1 811.7 818.2 821.7 824.6 824.7 634.2 818.1 818.7 818.8 818.9 476.7 603.4 615.6 617.6 618.3 11683.4 11742.9 11799.1 11828.9 11838.4 10296.5 10866.5 10894.5 11028.2 11131.2 8556.1 8991.2 9044.9 9221.3 9390.1 3220.0 3272.4 3285.4 3287.1 3358.9 38080.6 38290.4 38566.8 38579.4 38590.2 9004.5 9189.8 9368.6 9383.2 9628.1 14495.7 14549.1 14607.6 14615.4 14639.9 6028.5 6059.7 6150.3 6224.0 6241.7 3597.6 3620.0 3637.2 3664.4 3681.8 2591.0 2602.3 2609.5 2610.5 2618.1 464.1 465.6 466.9 472.1 473.8 487.6 554.8 574.9 606.4 609.3 7336.6 7802.9 8002.7 8027.1 8556.4 493.2 567.6 587.5 612.1 615.6 3371.0 3374.4 3522.1 3549.9 3661.4 46474.8 47199.3 47423.8 47629.5 47714.8 45760.9 46016.3 46753.8 46805.8 47475.3 38490.2 38656.2 39203.8 40016.2 40041.4 7664.2 7860.6 7971.5 8203.0 8436.2 28664.9 29190.4 29339.0 29646.7 29877.3 36722.6 37304.4 37777.8 39155.8 39194.5 10051.9 10184.4 10238.8 10316.6 10462.7 10138.4 10478.7 10561.8 10733.5 11062.6 10593.8 10713.5 10776.6 10792.2 11528.3 9574.6 9609.6 9704.7 9744.5 9752.3 9740.8 9846.7 9862.8 10045.8 10124.1 8632.5 8770.3 8778.5 9087.1 9167.3 9150.3 9203.4 9204.0 9247.0 9252.8 20:19:02 INFO - 2015-12-07 20:19:02,942 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:19:02 INFO - 2015-12-07 20:19:02,942 DEBUG : BROWSER_OUTPUT: 20:19:03 INFO - 2015-12-07 20:19:03,697 INFO : Browser exited with error code: 0 20:19:03 INFO - 2015-12-07 20:19:03,721 INFO : Completed test dromaeo_css (00:18:36) 20:19:03 INFO - 2015-12-07 20:19:03,721 INFO : Starting test kraken 20:19:03 INFO - 2015-12-07 20:19:03,721 DEBUG : operating with platform_type : linux_ 20:19:03 INFO - 2015-12-07 20:19:03,721 INFO : Initialising browser for kraken test... 20:19:03 INFO - 2015-12-07 20:19:03,727 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpivXFoM/profile http://localhost:34615/getInfo.html 20:19:08 INFO - 2015-12-07 20:19:08,194 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:19:08 INFO - 2015-12-07 20:19:08,194 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:19:08 INFO - 2015-12-07 20:19:08,194 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:19:08 INFO - 2015-12-07 20:19:08,194 DEBUG : BROWSER_OUTPUT: __metrics 20:19:08 INFO - 2015-12-07 20:19:08,278 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:19:08 INFO - 2015-12-07 20:19:08,339 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:19:08 ERROR - 2015-12-07 20:19:08,354 DEBUG : BROWSER_OUTPUT: JavaScript error: chrome://browser/content/tab-content.js, line 408: TypeError: content is null 20:19:09 INFO - 2015-12-07 20:19:09,147 INFO : Browser initialized. 20:19:09 INFO - 2015-12-07 20:19:09,147 INFO : Running cycle 1/1 for kraken test... 20:19:09 INFO - 2015-12-07 20:19:09,147 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpivXFoM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:19:21 INFO - 2015-12-07 20:19:21,227 DEBUG : BROWSER_OUTPUT: RSS: Main: 143613952 20:19:21 INFO - 2015-12-07 20:19:21,228 DEBUG : BROWSER_OUTPUT: 20:19:23 INFO - 2015-12-07 20:19:23,863 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:34615/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:24 INFO - 2015-12-07 20:19:24,448 DEBUG : BROWSER_OUTPUT: RSS: Main: 176533504 20:19:24 INFO - 2015-12-07 20:19:24,449 DEBUG : BROWSER_OUTPUT: 20:19:27 INFO - 2015-12-07 20:19:27,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:34615/tests/kraken/driver.html?testName=audio-dft) 20:19:27 INFO - 2015-12-07 20:19:27,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 168505344 20:19:27 INFO - 2015-12-07 20:19:27,754 DEBUG : BROWSER_OUTPUT: 20:19:30 INFO - 2015-12-07 20:19:30,725 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:34615/tests/kraken/driver.html?testName=audio-fft) 20:19:31 INFO - 2015-12-07 20:19:31,291 DEBUG : BROWSER_OUTPUT: RSS: Main: 154292224 20:19:31 INFO - 2015-12-07 20:19:31,291 DEBUG : BROWSER_OUTPUT: 20:19:33 INFO - 2015-12-07 20:19:33,323 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:34615/tests/kraken/driver.html?testName=audio-oscillator) 20:19:33 INFO - 2015-12-07 20:19:33,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 157163520 20:19:33 INFO - 2015-12-07 20:19:33,905 DEBUG : BROWSER_OUTPUT: 20:19:36 INFO - 2015-12-07 20:19:36,143 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:34615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:36 INFO - 2015-12-07 20:19:36,711 DEBUG : BROWSER_OUTPUT: RSS: Main: 157564928 20:19:36 INFO - 2015-12-07 20:19:36,712 DEBUG : BROWSER_OUTPUT: 20:19:39 INFO - 2015-12-07 20:19:39,703 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:34615/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:40 INFO - 2015-12-07 20:19:40,284 DEBUG : BROWSER_OUTPUT: RSS: Main: 158224384 20:19:40 INFO - 2015-12-07 20:19:40,284 DEBUG : BROWSER_OUTPUT: 20:19:43 INFO - 2015-12-07 20:19:43,706 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:34615/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:44 INFO - 2015-12-07 20:19:44,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 158728192 20:19:44 INFO - 2015-12-07 20:19:44,288 DEBUG : BROWSER_OUTPUT: 20:19:47 INFO - 2015-12-07 20:19:47,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:34615/tests/kraken/driver.html?testName=json-parse-financial) 20:19:47 INFO - 2015-12-07 20:19:47,758 DEBUG : BROWSER_OUTPUT: RSS: Main: 157851648 20:19:47 INFO - 2015-12-07 20:19:47,760 DEBUG : BROWSER_OUTPUT: 20:19:49 INFO - 2015-12-07 20:19:49,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:34615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:50 INFO - 2015-12-07 20:19:50,124 DEBUG : BROWSER_OUTPUT: RSS: Main: 170119168 20:19:50 INFO - 2015-12-07 20:19:50,124 DEBUG : BROWSER_OUTPUT: 20:19:52 INFO - 2015-12-07 20:19:52,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:52 INFO - 2015-12-07 20:19:52,633 DEBUG : BROWSER_OUTPUT: RSS: Main: 167997440 20:19:52 INFO - 2015-12-07 20:19:52,633 DEBUG : BROWSER_OUTPUT: 20:19:54 INFO - 2015-12-07 20:19:54,787 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:55 INFO - 2015-12-07 20:19:55,370 DEBUG : BROWSER_OUTPUT: RSS: Main: 178384896 20:19:55 INFO - 2015-12-07 20:19:55,370 DEBUG : BROWSER_OUTPUT: 20:19:57 INFO - 2015-12-07 20:19:57,940 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:58 INFO - 2015-12-07 20:19:58,526 DEBUG : BROWSER_OUTPUT: RSS: Main: 185729024 20:19:58 INFO - 2015-12-07 20:19:58,527 DEBUG : BROWSER_OUTPUT: 20:20:01 INFO - 2015-12-07 20:20:01,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:20:01 INFO - 2015-12-07 20:20:01,699 DEBUG : BROWSER_OUTPUT: RSS: Main: 183537664 20:20:01 INFO - 2015-12-07 20:20:01,700 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,451 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:34615/tests/kraken/driver.html?testName=ai-astar) 20:20:03 INFO - 2015-12-07 20:20:03,701 DEBUG : BROWSER_OUTPUT: RSS: Main: 242282496 20:20:03 INFO - 2015-12-07 20:20:03,701 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,702 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:20:03 INFO - 2015-12-07 20:20:03,702 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;108;113;112;113;102;113;112;105 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;146;128;157;169;132;153;154;129;168;129 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;160;162;159;165;161;160;162;161;160 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;86;92;72;71;72;93;92;71 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;130;94;95;94;142;94;94;128 20:20:03 INFO - 2015-12-07 20:20:03,703 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;111;110;110;109;110 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;148;147;148;147;147;147 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;96;95;95;96;96;95;95;96 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;73;74;72;73;74;73;72;73;72 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;69;69;68;69;68;68;69;69;68 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;89;84;86;84;85;85;85;86;85;86 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;127;129;120;125;127;129;130;122;120 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;148;147;145;134;147;145;146;138 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;70;71;71;72;70;70;69;68 20:20:03 INFO - 2015-12-07 20:20:03,704 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:20:03 INFO - 2015-12-07 20:20:03,705 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:20:03 INFO - 2015-12-07 20:20:03,705 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1007 20:20:03 INFO - 2015-12-07 20:20:03,705 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:20:03 INFO - 2015-12-07 20:20:03,705 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548403701__endTimestamp 20:20:03 INFO - 2015-12-07 20:20:03,705 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,708 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:112.50 stddev:3.91 (3.5%) stddev-sans-first:4.14 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 108.0 113.0 112.0 113.0 102.0 113.0 112.0 105.0 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.50 Median:153.50 stddev:16.13 (10.5%) stddev-sans-first:17.11 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: Values: 146.0 128.0 157.0 169.0 132.0 153.0 154.0 129.0 168.0 129.0 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.70 (1.1%) stddev-sans-first:1.76 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: Values: 160.0 160.0 162.0 159.0 165.0 161.0 160.0 162.0 161.0 160.0 20:20:03 INFO - 2015-12-07 20:20:03,709 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.20 Median:79.00 stddev:10.12 (12.8%) stddev-sans-first:10.39 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 86.0 92.0 72.0 71.0 72.0 93.0 92.0 71.0 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.00 Median:94.00 stddev:19.20 (20.4%) stddev-sans-first:19.95 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 130.0 94.0 95.0 94.0 142.0 94.0 94.0 128.0 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.63 (0.6%) stddev-sans-first:0.67 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 111.0 110.0 110.0 109.0 110.0 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.50 Median:148.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 148.0 147.0 148.0 147.0 147.0 147.0 20:20:03 INFO - 2015-12-07 20:20:03,710 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 96.0 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.00 Median:73.00 stddev:0.82 (1.1%) stddev-sans-first:0.78 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: Values: 74.0 73.0 74.0 72.0 73.0 74.0 73.0 72.0 73.0 72.0 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:69.00 stddev:0.70 (1.0%) stddev-sans-first:0.53 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: Values: 67.0 69.0 69.0 68.0 69.0 68.0 68.0 69.0 69.0 68.0 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.50 Median:85.50 stddev:1.43 (1.7%) stddev-sans-first:0.78 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: Values: 89.0 84.0 86.0 84.0 85.0 85.0 85.0 86.0 85.0 86.0 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.60 Median:127.00 stddev:3.72 (2.9%) stddev-sans-first:3.91 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 129.0 120.0 125.0 127.0 129.0 130.0 122.0 120.0 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,711 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.40 Median:146.50 stddev:5.30 (3.6%) stddev-sans-first:4.89 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 148.0 147.0 145.0 134.0 147.0 145.0 146.0 138.0 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.00 Median:70.00 stddev:1.15 (1.6%) stddev-sans-first:1.17 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 71.0 71.0 72.0 70.0 70.0 69.0 68.0 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:20:03 INFO - 2015-12-07 20:20:03,712 DEBUG : BROWSER_OUTPUT: 20:20:04 INFO - 2015-12-07 20:20:04,589 INFO : Browser exited with error code: 0 20:20:04 INFO - 2015-12-07 20:20:04,645 INFO : Completed test kraken (00:01:00) 20:20:04 INFO - 2015-12-07 20:20:04,645 INFO : Starting test v8_7 20:20:04 INFO - 2015-12-07 20:20:04,645 DEBUG : operating with platform_type : linux_ 20:20:04 INFO - 2015-12-07 20:20:04,645 INFO : Initialising browser for v8_7 test... 20:20:04 INFO - 2015-12-07 20:20:04,651 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCI2GaX/profile http://localhost:34615/getInfo.html 20:20:08 INFO - 2015-12-07 20:20:08,717 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:20:08 INFO - 2015-12-07 20:20:08,717 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:20:08 INFO - 2015-12-07 20:20:08,717 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:20:08 INFO - 2015-12-07 20:20:08,717 DEBUG : BROWSER_OUTPUT: __metrics 20:20:08 INFO - 2015-12-07 20:20:08,855 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:20:08 INFO - 2015-12-07 20:20:08,923 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:20:10 INFO - 2015-12-07 20:20:10,121 INFO : Browser initialized. 20:20:10 INFO - 2015-12-07 20:20:10,121 INFO : Running cycle 1/1 for v8_7 test... 20:20:10 INFO - 2015-12-07 20:20:10,122 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCI2GaX/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:20:22 INFO - 2015-12-07 20:20:22,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 143007744 20:20:22 INFO - 2015-12-07 20:20:22,211 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,567 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:34615/tests/v8_7/run.html (next: http://localhost:34615/tests/v8_7/run.html) 20:20:43 INFO - 2015-12-07 20:20:43,817 DEBUG : BROWSER_OUTPUT: RSS: Main: 442535936 20:20:43 INFO - 2015-12-07 20:20:43,818 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,819 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:20:43 INFO - 2015-12-07 20:20:43,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:20:43 INFO - 2015-12-07 20:20:43,819 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:20:43 INFO - 2015-12-07 20:20:43,819 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:20:43 INFO - 2015-12-07 20:20:43,819 DEBUG : BROWSER_OUTPUT: |0;Richards;166.27868307283006 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.08113137327874 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.78449958182324 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5186.5284974093265 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1998.0039920159682 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |6;Boyer;11928.57142857143 20:20:43 INFO - 2015-12-07 20:20:43,820 DEBUG : BROWSER_OUTPUT: |7;RegExp;27486.486486486487 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: |8;Splay;611.21267519805 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548443818__endTimestamp 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:20:43 INFO - 2015-12-07 20:20:43,821 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.28 Median:166.28 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: Values: 166.3 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.08 Median:186.08 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: Values: 186.1 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.78 Median:278.78 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: Values: 278.8 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,822 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5186.53 Median:5186.53 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,823 DEBUG : BROWSER_OUTPUT: Values: 5186.5 20:20:43 INFO - 2015-12-07 20:20:43,823 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,823 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1998.00 Median:1998.00 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,823 DEBUG : BROWSER_OUTPUT: Values: 1998.0 20:20:43 INFO - 2015-12-07 20:20:43,823 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: Values: 781.9 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11928.57 Median:11928.57 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: Values: 11928.6 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27486.49 Median:27486.49 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,824 DEBUG : BROWSER_OUTPUT: Values: 27486.5 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:611.21 Median:611.21 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: Values: 611.2 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: Values: 4830.9 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:20:43 INFO - 2015-12-07 20:20:43,825 DEBUG : BROWSER_OUTPUT: 20:20:44 INFO - 2015-12-07 20:20:44,794 INFO : Browser exited with error code: 0 20:20:44 INFO - 2015-12-07 20:20:44,808 INFO : Completed test v8_7 (00:00:40) 20:20:44 INFO - 2015-12-07 20:20:44,912 INFO : Completed test suite (00:20:18) 20:20:44 INFO - 2015-12-07 20:20:44,912 DEBUG : Working with test: dromaeo_css 20:20:44 INFO - 2015-12-07 20:20:44,912 DEBUG : Generating results file: dromaeo_css 20:20:44 INFO - 2015-12-07 20:20:44,913 DEBUG : Working with test: kraken 20:20:44 INFO - 2015-12-07 20:20:44,913 DEBUG : Generating results file: kraken 20:20:44 INFO - 2015-12-07 20:20:44,913 INFO : javascript benchmark 20:20:44 INFO - 2015-12-07 20:20:44,914 DEBUG : Working with test: v8_7 20:20:44 INFO - 2015-12-07 20:20:44,914 DEBUG : Generating results file: v8_7 20:20:44 INFO - 2015-12-07 20:20:44,914 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:45 INFO - 2015-12-07 20:20:45,055 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 20:20:45 INFO - 2015-12-07 20:20:45,055 DEBUG : process_Request line: dromaeo_css 6163.86 graph.html#tests=[[72,132,35]] 20:20:45 INFO - 2015-12-07 20:20:45,055 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:45 INFO - 2015-12-07 20:20:45,196 DEBUG : process_Request line: kraken 1521.60 graph.html#tests=[[232,132,35]] 20:20:45 INFO - 2015-12-07 20:20:45,196 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:45 INFO - 2015-12-07 20:20:45,224 DEBUG : process_Request line: v8_7 19788.47 graph.html#tests=[[230,132,35]] 20:20:45 INFO - 2015-12-07 20:20:45,225 INFO : javascript benchmark 20:20:45 INFO - 2015-12-07 20:20:45,229 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2593.14426239341, 2717.266338088716, 2721.5509440942246, 2733.822301550399, 2737.2062101990423, 4496.865094047183, 4640.3967484227005, 4733.0, 4734.597559207467, 4750.121227572897, 4598.356230127785, 4659.207934651109, 4670.042641258542, 4769.284607308906, 4770.4275486941615, 4277.550857160008, 4350.260455722519, 4361.760103194323, 4371.27873900806, 4448.065906159694, 4327.350897365389, 4370.562943705636, 4377.562243775629, 4406.5373135820755, 4436.778161091933, 4124.52567954683, 4231.365295205713, 4377.430933978594, 4424.960134368421, 4434.201843668138, 4280.507741609693, 4284.764337961411, 4295.785210739482, 4296.205202037633, 4299.699021068526, 4227.196832601796, 4230.069384735353, 4232.640225580829, 4235.216484950294, 4241.4698162729655, 4566.40636717228, 4575.6568257380495, 4637.536246375335, 4657.860264192046, 4674.32222327764, 5060.898782024376, 5090.745462726849, 5095.719735414587, 5134.7689353978785, 5138.152204886189, 4793.880152996168, 4896.926546101811, 5080.060188865072, 5091.287219789232, 5103.2855400244, 4559.77201139945, 4598.080383923195, 4692.436907571113, 4695.671303008825, 4734.621230301567, 5116.155834287375, 5154.871128221749, 5166.302549155891, 5171.482851714798, 5210.348706411699, 4689.718616882998, 4808.110499557593, 4981.12830254704, 4981.701097934136, 4983.327250821165, 4877.170880950247, 4932.210846264652, 4961.776720047606, 4970.304157417964, 4978.0292842896015, 4963.6277279204205, 4968.031233909425, 4968.826091086795, 4974.801007959641, 5006.599472042228, 4950.108980383566, 4952.603791696655, 4956.529129732669, 4965.627577931669, 5000.874978125503, 4041.3533834586915, 4127.7936103194725, 4131.380292956081, 4202.138561594866, 4312.676549258818, 3722.3113723960614, 3725.739198256096, 3732.5147730794824, 3756.4553139795125, 3763.4354846773203, 4319.762413067311, 4322.416473776063, 4323.135372925428, 4324.827006919751, 4360.4331436913, 4829.251466022772, 4940.987097644974, 4941.407031156213, 4956.826511072095, 5075.3402057733, 4308.655307575386, 4341.175176716414, 4343.326784348431, 4350.521442641307, 4371.584699453547, 4526.88682782933, 4547.613452856478, 4549.522300158435, 4551.112533056088, 4585.541445855388, 4535.342375355621, 4646.488886222581, 4650.720956742674, 4700.976495117503, 4789.3055506952, 4925.813656668771, 4930.901381972269, 4936.481669424802, 4945.455999839943, 4993.425756038102, 4736.881577960578, 4738.763061846963, 4747.0, 4749.05018996209, 4790.880227994328, 4795.304680821192, 4839.975800120977, 4881.51184881509, 4915.066137433876, 4937.728424936663, 5013.2981382607195, 5088.0, 5090.312807770903, 5115.1559992600805, 5137.049645815536, 4870.756462176806, 4913.434954980223, 4913.975430122827, 4915.483874193301, 4965.981973695311, 4615.769211539342, 4719.315699223662, 4719.905601888012, 4777.665563410528, 4913.950860491349, 4748.3827102477835, 4794.520547945178, 4795.784189711401, 4808.110499557593, 4825.30033145199, 4938.407391113089, 4940.950590494049, 4945.18404463274, 4952.083864484937, 4990.476000019946, 4648.558386953234, 4715.740634265148, 4773.737444440589, 4778.307145463818, 4831.227003679394], "unit": "ms", "name": "dojo.html", "value": 4593.619671897928}, {"lowerIsBetter": false, "replicates": [534.3854567247664, 542.224618795123, 542.7855996881232, 570.7289037707087, 571.8284514645603, 25051.874740626296, 34783.652163478386, 35457.46813797795, 35479.2904141917, 35500.46749298763, 39917.40123898144, 39981.40027899584, 40435.59564404355, 40511.59488405115, 40523.59476405235, 6989.05647737554, 7114.786556403316, 7890.8816367754525, 8051.154628763983, 8067.9193208068045, 10199.23505737069, 10440.895591044105, 10441.112505437048, 10442.843357349646, 10456.529456174452, 10108.342957707762, 10210.744731381701, 10211.642592509264, 10213.182945364353, 10224.130948869319, 7232.674529646152, 7388.667509962064, 10029.24780641451, 10087.798244035079, 10313.226508011929, 9977.201823854075, 10143.18854491639, 10149.086582207563, 10149.949250253776, 10151.340162889388, 36991.260174796626, 37298.44052339217, 37491.81254093712, 37548.49418069849, 37585.62414375848, 2730.9044183453484, 2749.340158361999, 2846.9145925622265, 3064.846757662108, 3100.4264211121017, 26364.86817565919, 26382.0, 26829.19512414611, 26936.461270774475, 27632.171034868785, 3415.0995905060936, 3421.2815308785184, 3441.1397150712323, 3469.8785542505893, 3546.343926373629, 221071.0, 221737.0, 221794.0, 221922.0, 223541.99999999837, 51014.48985510172, 55468.0, 55934.72032639892, 55935.0, 56017.439825602036, 46367.76816115898, 46530.767346163055, 46599.0, 46660.0, 64668.676656616415, 12824.615261542169, 13249.668758280928, 13333.866661333263, 13359.398827052806, 13371.264580447974, 9895.65365212214, 9922.107010368956, 9923.1069203772, 9982.750431239132, 9985.750356241153, 18797.342093026953, 18962.62074758497, 18973.620527589646, 18977.0, 18998.525036874187, 7475.43934204926, 7699.692012319444, 7823.748200287927, 7848.725294614661, 7897.565633890191, 825.8719898415756, 891.777055736066, 901.4771432569225, 977.0376179463223, 996.2776986684596, 25877.74122258791, 25979.22062338133, 26467.338316541856, 26481.0, 26532.8673356632, 964.1659964130977, 975.9609615615437, 976.6532880827347, 1034.7723500829804, 1040.7554224757175, 13686.65783355424, 13747.38136783847, 14103.576892693236, 14129.434822606981, 14156.716865662835, 261896.0, 266284.0, 266735.0, 266778.0, 267416.0, 44988.10023799571, 45113.0, 45236.77381613137, 45269.32096018562, 45287.547124528995, 1185.2264309471411, 1196.491491116272, 1204.1691233049344, 1206.4993027893502, 1215.2890559022894, 25061.49877002486, 25116.0, 26212.344691382867, 26235.86882065654, 26240.73759262383, 40354.59645403508, 40753.1849363017, 40782.0, 40803.0, 40809.38785918273, 228420.0, 233148.0, 241660.0, 249784.0, 255996.0, 24873.253802385956, 24906.63013534273, 24939.750602494467, 24940.625890612017, 25265.494690105726, 32217.677823221467, 32287.192820179684, 33205.83397083096, 33231.0, 38417.61582384252, 28822.855885720437, 29090.0, 29232.707672923, 29737.0, 29744.10767676973, 28699.713002869703, 28895.133146005654, 28905.42189156163, 29074.27314317159, 29126.41747165087, 31914.52128218125, 32161.195970100936, 32476.025719228463, 32551.67448325581, 32640.510392344608, 27702.44595108127, 28101.297467563476, 29955.400891981604, 30238.54642180413, 30343.544846827757, 22777.31668049961, 22885.199018034287, 23172.652410214196, 23278.418039549146, 23281.0], "unit": "ms", "name": "ext.html", "value": 16786.30231353635}, {"lowerIsBetter": false, "replicates": [284.9615301934241, 286.13159062246086, 286.3899893227425, 287.3176206509541, 291.8234468146772, 13194.274314912676, 13653.795193072112, 15165.317560709767, 15578.610534736637, 15582.142982135992, 12277.75444491112, 13256.40346184424, 13467.865321346784, 13573.728525429486, 13602.047856650039, 4125.608067233608, 4236.894077648052, 4376.474823021242, 4490.685652004361, 4491.124230775, 4414.558544145591, 4442.888927776815, 4450.666200034994, 4450.910981780363, 4451.198784218839, 4440.644748420119, 4451.1542806866755, 4452.10957808438, 4453.332000199964, 4531.864044078683, 4402.207602631525, 4498.617617502517, 4500.932486012696, 4503.347014682852, 4505.234110201257, 4363.759993200372, 4366.0, 4368.825246990116, 4371.628411585019, 4372.234858899712, 10530.210234232463, 10661.253712240146, 10667.573297068107, 10675.626353077683, 11241.494132764044, 1735.0977491704368, 1770.6635739209637, 1798.6043070524463, 1826.4155470249525, 1891.6878715012006, 8177.713780017671, 8192.385571082134, 8233.3824963128, 8562.614682339248, 8681.869771953427, 1723.0271339316537, 1750.439859245042, 1757.182909946868, 1772.8493078088377, 1774.6805574996495, 55701.16448253239, 57971.420285797445, 58421.41578584202, 58624.0, 59588.40411595915, 9470.95264523673, 9636.22910167185, 9698.0, 9711.465869377253, 9775.706728798148, 10742.624008159677, 10744.247902646739, 11037.83443248352, 12237.20458170216, 12277.386130693609, 5007.324011258506, 5121.769520371592, 5253.737313134328, 6833.726650933907, 6843.965780171067, 6166.691665416712, 6174.073888916609, 6226.968865155645, 6227.9377206227355, 6250.937490625036, 4025.5370632377067, 4029.1538776857187, 4045.3931910213705, 4090.570490098556, 4096.938545921814, 1647.571631375851, 1698.7112190927571, 1723.7931448226293, 1728.7752592162938, 1735.5747841778846, 335.92441700617167, 336.8534687410935, 853.799357151069, 881.6737807011318, 975.9463229522445, 15267.160306183045, 16641.334346625998, 16924.0, 17303.74044389335, 17310.82689173092, 817.5912043978011, 817.652497688492, 848.6053984897053, 855.8331125430482, 916.6562539047857, 8670.393072484992, 8903.821923561492, 9441.150296473214, 9624.37441566296, 9630.807383852283, 485062.0, 486714.0, 493690.0, 495602.0, 496041.0, 69443.0, 71714.64142679253, 72739.0, 74499.0, 74721.0, 1085.913126949858, 1087.7552550676035, 1111.1943840715578, 1136.2046567402851, 1136.471540733563, 14410.567682969528, 14696.55910322692, 15095.245237738289, 15266.618334541725, 15360.692786144438, 23728.644070339305, 33166.00501984944, 33276.66723332736, 33452.49821252634, 34961.0, 39604.0, 40943.590564093975, 40971.1805763889, 41511.0, 42491.57508424876, 8612.354073444641, 8677.0, 8802.25180859634, 8865.246454051477, 8866.866996995179, 11911.463984120563, 11997.700057498632, 13726.65683357924, 16086.034837909294, 16225.918870406045, 13620.114692544952, 13653.522126725517, 13913.72172556523, 14108.717825643635, 14175.929120354333, 13400.597982060553, 13549.525766598123, 13731.725365492435, 13942.721145577234, 14166.78749818733, 13294.534691285759, 13319.86680133225, 13649.181049137083, 13770.0, 14110.647233819236, 8862.113788621085, 8902.421342612968, 8931.240844528287, 8940.642374305215, 8942.150495702897, 13545.32273386307, 13831.446742130202, 13850.58448246514, 14081.0, 14155.716885662436], "unit": "ms", "name": "jquery.html", "value": 7777.491003867275}, {"lowerIsBetter": false, "replicates": [1323.8080478330642, 1366.1325058587793, 1402.7475054490187, 1582.185174635063, 1664.4091347571616, 5941.613795103321, 6814.62519561424, 6911.481638877091, 6934.8266293342695, 6942.895856562156, 6867.141607299088, 7062.046623705798, 7069.116360454943, 7069.964650176755, 7075.46933979951, 2040.2451093095538, 2072.202202152175, 2074.4295318787304, 2077.6156411064003, 2079.2514694709894, 2043.1520918818671, 2079.979200208001, 2086.7287252657134, 2102.211670623516, 2106.2522804404443, 1987.155458929949, 2010.9497262568407, 2031.451508092814, 2033.8677985930867, 2035.6132334856404, 1981.375866602023, 2001.959960800776, 2005.5587770690497, 2006.7190593316948, 2013.8791672499624, 1988.3239698502434, 2004.0881398963581, 2039.3576023552534, 2041.9183232670675, 2044.9079791409422, 6937.7571784987285, 7049.0, 7053.470989675795, 7056.082709247765, 7093.467989900726, 4045.4538637283886, 4091.40674602184, 4104.0, 4123.9175216495505, 4125.071858831769, 2579.57437022891, 2612.7909767218575, 2613.5556955317643, 2628.8028397870235, 2651.0853755454336, 826.1655727715051, 847.3560094328293, 847.720252316734, 851.6082602003086, 1741.9912900435543, 9330.533473326375, 9411.717648470556, 9433.386829855968, 9443.244540436748, 9483.099105584959, 3552.0764601203873, 3554.4845997330244, 3599.478075679064, 3627.3289441453417, 3664.0839790052487, 7418.072740907387, 7428.257174282637, 7433.368163706145, 7443.292887175709, 7489.737859174903, 4039.4546736190828, 4044.3933409988736, 4054.8378064877074, 4059.512858457004, 4063.0858056937545, 3027.606411166534, 3044.3150291184747, 3641.417373220272, 3728.3289007978824, 3732.0856390184576, 3093.3503964167326, 3167.509036099362, 3180.9522857157162, 3187.665295144023, 3199.328141090397, 885.7874110213502, 909.2952961454926, 918.7611221082567, 921.6037104045325, 924.6948506992676, 858.1932982995963, 879.9836189201483, 1151.7638884028754, 1161.5586077290575, 1167.6847251242118, 6553.672316384162, 6568.7372505099265, 6604.8348791280605, 6618.867622647616, 6654.201495820435, 1006.3659894266565, 1025.3489034463169, 1029.161233594633, 1033.3180101133216, 1050.76883085721, 5175.249588809602, 5206.505381988705, 5211.635185537052, 5215.0, 5217.556507696812, 8116.188381161955, 8116.228958248957, 8128.715494957648, 8190.50856948585, 8358.958205209057, 8263.049749278789, 8335.749927502186, 8349.165083491602, 8367.874481882776, 8377.2460478556, 6518.837029074311, 6526.706298216592, 6570.605763654196, 6626.768063117865, 6668.499862510331, 6618.0, 6668.899966500409, 6673.666316684244, 6676.232233293234, 6682.46540276767, 7527.435442341955, 7541.660625271767, 7559.508631938907, 7566.167721550515, 7666.156722760604, 7663.693452261847, 7716.652750626347, 7841.059072911287, 7874.685012599661, 7886.132525422314, 5137.357830271216, 5248.580113590827, 5960.135780311917, 6030.276366836008, 6055.122007308827, 6423.229212494531, 6550.901736474052, 6585.736570537125, 6588.472922166311, 6594.868102637824, 6135.877282454237, 6177.752889884354, 6272.780452684134, 6282.968585157228, 6378.851806674843, 6135.539834512519, 6207.782727604512, 6278.246610406781, 6286.277078136073, 6348.047792831112, 6179.783707570214, 6194.38056194377, 6198.845028874314, 6199.535034872493, 6212.875742485035, 5858.8242352729485, 5877.23595932526, 5880.882382352243, 5886.911696324644, 5895.852603684943, 5778.739956701875, 5812.534997200299, 5878.0, 5885.646861188342, 5887.381824908494], "unit": "ms", "name": "mootools.html", "value": 3978.0970716417974}, {"lowerIsBetter": false, "replicates": [251.7117900004495, 255.69572209071208, 260.39198471568886, 260.67025213105427, 262.1832990235417, 5295.152775555912, 5368.597355198366, 5385.892282154355, 5388.353397592285, 5388.973055134724, 5082.542571168594, 5157.7936882524655, 5252.8161514347, 5255.684658920468, 5258.1849813278905, 3996.780177090259, 3997.3804060370544, 3997.4403583498333, 3998.920021599566, 4000.919981600366, 4002.379631157161, 4003.219372222418, 4005.038790690228, 4005.2790497710403, 4016.0, 3952.26883026641, 3955.189186216833, 3955.3275943089743, 3955.920881582381, 3958.2083583283315, 3866.168773713665, 3945.960540394588, 3950.4469374287623, 3960.7029472789513, 3962.346212874872, 3403.9659603403898, 3406.318736252759, 3407.9488807667904, 3409.1817963688786, 3419.042668052949, 5148.871278218037, 5161.61287903405, 5167.147420675584, 5167.276581278624, 5170.663906846043, 4562.520935301812, 4564.931526027112, 4566.885827854297, 4569.794359253809, 4572.497025327211, 5593.0, 5599.412061733541, 5606.775728970836, 5615.494605485526, 5617.606767526275, 3594.0116467971256, 3694.685951694082, 3696.537932758405, 3704.555453345589, 3708.9443658344876, 5708.372079071299, 5812.273465816773, 5861.3552509223955, 5959.523238140939, 5962.522998160137, 3676.0258531489176, 3685.7972811495624, 3688.133288677159, 3688.944665830015, 3691.7784932903573, 3733.0853940784136, 3825.598312177237, 3847.076701591598, 3848.7690738555775, 3851.0372406898277, 4524.751138687404, 4545.795439205243, 4551.567601077959, 4555.931661025087, 4557.384753058361, 5389.7035663038905, 5423.918641220384, 5552.888942221133, 5657.462541058593, 5665.716714164275, 1284.0818814547642, 1351.3851197705021, 1353.3706826325806, 1356.3082827757717, 1356.6947436826636, 863.6545381847186, 870.6909047288121, 882.633707011583, 885.2121611765534, 889.857622780365, 4947.134251505972, 4957.3307603473795, 4963.851084467472, 4968.677035992649, 4968.701877887338, 5898.469137777534, 5907.940920590825, 5909.409059094142, 5911.40885911414, 5912.70436478183, 4950.579200767975, 4952.108620448282, 4961.08219979305, 4962.478939711278, 4966.056449274626, 3093.072078376478, 3158.2578094147857, 3187.2031992002, 3187.936241275208, 3192.409404260219, 5555.361133469622, 5624.606277560613, 5628.296462942132, 5631.943680563224, 5634.661920284714, 6101.0, 6102.816915492543, 6118.296395914438, 6127.908081378783, 6140.631562106288, 5612.635178713371, 5626.578006649518, 5631.18347839561, 5633.436656334252, 5640.0, 5790.247267855152, 5973.910391344047, 5974.283086029531, 5980.790672326448, 5987.820365389045, 5832.883342333214, 5837.970810145922, 5841.474267315962, 5848.327442344185, 5855.38518455556, 5634.042212823748, 5636.4927156556105, 5639.436056394492, 5639.689817060101, 5642.181883626933, 3547.9290414191055, 3554.3246783111126, 3666.7066634669695, 3813.1420430402936, 3863.188730366542, 5762.827115186551, 5799.0, 5805.535557155333, 5806.187133801187, 5806.622569532967, 5676.68778217202, 5677.687727175045, 5680.914786278292, 5681.062624667049, 5683.204351390891, 5670.688112153871, 5675.31896172462, 5681.17622944679, 5681.460261275172, 5683.77264909399, 5434.701091440009, 5553.8333849984565, 5557.083081291542, 5558.416366281483, 5564.165375193753, 5693.9181555505975, 5698.344690360662, 5706.914396284142, 5711.8857622848145, 5714.228579141763, 5576.10782274834, 5577.135543990688, 5587.078132108157, 5587.1339942309005, 5589.776408943597], "unit": "ms", "name": "prototype.html", "value": 4134.221794153594}, {"lowerIsBetter": false, "replicates": [632.8545332947368, 668.0680450771177, 682.2972338491353, 773.292437419761, 781.4334607409629, 12021.338826364547, 12285.570005049825, 12354.814677779841, 12360.320182389976, 12366.0, 11287.15346349023, 11764.588239411622, 11766.176367654267, 11772.99929505993, 11843.881561184386, 612.1246617337206, 621.9985822825248, 622.3185611755143, 779.1273773373829, 798.6446031515977, 612.9785457508988, 616.0420546050889, 757.1708978668377, 784.051297929506, 786.0528063683248, 811.7037281392279, 818.1654712193559, 821.7288294862681, 824.6165533027141, 824.68661908475, 634.194572892424, 818.1327792539897, 818.6602559937619, 818.8116733151379, 818.9222023907719, 476.67586041491774, 603.4267445926343, 615.602936106209, 617.5677026081761, 618.3229363846581, 11683.357415342152, 11742.88257117435, 11799.115066370057, 11828.940855295668, 11838.408079596073, 10296.536655850505, 10866.45667716611, 10894.455277236186, 11028.22802403832, 11131.220814542905, 8556.101609331055, 8991.235744961687, 9044.8643270351, 9221.308401869886, 9390.107939745712, 3220.033989803073, 3272.4109660261142, 3285.4414749492644, 3287.063186991696, 3358.9160270993175, 38080.61919380799, 38290.42564361537, 38566.80716596399, 38579.421308680394, 38590.22819543621, 9004.459732416077, 9189.81620367589, 9368.62525498986, 9383.202427793714, 9628.085331893459, 14495.710085798224, 14549.054311469721, 14607.634809129644, 14615.415383384758, 14639.853601463848, 6028.457438830526, 6059.7273122709585, 6150.323464418911, 6223.96888015557, 6241.656708881055, 3597.6222496638, 3619.9638003620153, 3637.2361804021452, 3664.3953747631344, 3681.815909204529, 2591.002464051354, 2602.2843717977707, 2609.4781043791318, 2610.4909542639, 2618.0967566189634, 464.0695405711527, 465.6344769356039, 466.8902807840155, 472.1454167956011, 473.81284392665395, 487.60747598183093, 554.8474169603392, 574.9252597162425, 606.4269265544018, 609.2840911928466, 7336.633168341562, 7802.921970780333, 8002.7199048033035, 8027.117017128111, 8556.443831150955, 493.19116648696166, 567.6026781253139, 587.5152998776027, 612.124661733725, 615.5967841064111, 3371.005553361764, 3374.4263475209273, 3522.0842580929143, 3549.94675079874, 3661.377565813818, 46474.76762616165, 47199.292010619865, 47423.76288118537, 47629.52370476251, 47714.76142619265, 45760.855978600805, 46016.30975535369, 46753.766231169306, 46805.76597117061, 47475.28787068197, 38490.23019539649, 38656.22687546234, 39203.803980979916, 40016.19967600632, 40041.39937900934, 7664.195259497673, 7860.5676687782725, 7971.481853679492, 8202.958985205036, 8436.156384361515, 28664.856675716488, 29190.416191675624, 29339.0, 29646.703532964395, 29877.253068673457, 36722.63277367192, 37304.44043339298, 37777.81111094427, 39155.804220978716, 39194.53290207084, 10051.899481005388, 10184.439855808001, 10238.795224095626, 10316.587336506456, 10462.738431539272, 10138.442385668859, 10478.685639430829, 10561.841572376266, 10733.463326833784, 11062.612808551663, 10593.841092383465, 10713.517891695048, 10776.622818201326, 10792.190585705946, 11528.250663706833, 9574.569144388659, 9609.615615375586, 9704.660336888175, 9744.464054477072, 9752.317337786288, 9740.805183896424, 9846.704598862045, 9862.753431164278, 10045.799084018425, 10124.139448146696, 8632.482051076955, 8770.295184663999, 8778.473291602524, 9087.136722011399, 9167.266618670623, 9150.313726470407, 9203.35576509638, 9204.0, 9246.9537652314, 9252.768680782765], "unit": "ms", "name": "yui.html", "value": 5559.712855115695}], "name": "dromaeo_css", "value": 6163.8607891773745}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 108.0, 113.0, 112.0, 113.0, 102.0, 113.0, 112.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [146.0, 128.0, 157.0, 169.0, 132.0, 153.0, 154.0, 129.0, 168.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.5}, {"lowerIsBetter": true, "replicates": [160.0, 160.0, 162.0, 159.0, 165.0, 161.0, 160.0, 162.0, 161.0, 160.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 86.0, 92.0, 72.0, 71.0, 72.0, 93.0, 92.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 79.2}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 130.0, 94.0, 95.0, 94.0, 142.0, 94.0, 94.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 106.0}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 111.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 148.0, 147.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [74.0, 73.0, 74.0, 72.0, 73.0, 74.0, 73.0, 72.0, 73.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 73.0}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 69.0, 68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [89.0, 84.0, 86.0, 84.0, 85.0, 85.0, 85.0, 86.0, 85.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.5}, {"lowerIsBetter": true, "replicates": [127.0, 127.0, 129.0, 120.0, 125.0, 127.0, 129.0, 130.0, 122.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.6}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 148.0, 147.0, 145.0, 134.0, 147.0, 145.0, 146.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.4}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 71.0, 72.0, 70.0, 70.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.0}], "name": "kraken", "value": 1521.6}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [166.27868307283006], "unit": "score", "name": "Richards", "value": 212.306228}, {"lowerIsBetter": false, "replicates": [186.08113137327874], "unit": "score", "name": "DeltaBlue", "value": 355.31813200000005}, {"lowerIsBetter": false, "replicates": [278.78449958182324], "unit": "score", "name": "Encrypt", "value": 954.7912470000005}, {"lowerIsBetter": false, "replicates": [5186.5284974093265], "unit": "score", "name": "Decrypt", "value": 51.32161138861136}, {"lowerIsBetter": false, "replicates": [1998.0039920159682], "unit": "score", "name": "RayTrace", "value": 370.36412487512496}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [11928.57142857143], "unit": "score", "name": "Boyer", "value": 55.871149700598814}, {"lowerIsBetter": false, "replicates": [27486.486486486487], "unit": "score", "name": "RegExp", "value": 33.14301376597835}, {"lowerIsBetter": false, "replicates": [611.21267519805], "unit": "score", "name": "Splay", "value": 133.3267507477568}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19788.468613312627}]} 20:20:45 INFO - RETURN: dromaeo_css: 6163.86 20:20:45 INFO - RETURN: kraken: 1521.60 20:20:45 INFO - RETURN: v8_7: 19788.47 20:20:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19788.47"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6163.86"}}} 20:20:45 INFO - Return code: 0 20:20:45 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:45 ERROR - # TBPL SUCCESS # 20:20:45 INFO - Running post-action listener: _resource_record_post_action 20:20:45 INFO - Running post-run listener: _resource_record_post_run 20:20:46 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 518832128; Read time: 4; Write time: 512044 20:20:46 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 243212288; Read time: 0; Write time: 348852 20:20:46 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 274726912; Read time: 4; Write time: 162728 20:20:46 INFO - Running post-run listener: _upload_blobber_files 20:20:46 INFO - Blob upload gear active. 20:20:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:20:46 INFO - Copying logs to upload dir... 20:20:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1271.508933 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 11 secs) (at 2015-12-07 20:20:46.398597) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:46.403728) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009946 build_url: 'https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:46.457436) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:46.458088) ========= 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=f5f5a079460e1a9be8676904000001c1-1449537093.621862-1211052391 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004473 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:46.508112) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:20:46.508444) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:20:46.508725) ========= ========= Total master_lag: 0.27 =========