builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-055 starttime: 1449547173.84 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.842699) ========= 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.843086) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.843375) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006495 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.871026) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.871317) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.888588) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.888841) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004596 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.937894) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.938169) ========= 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.938519) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:33.938788) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-07 19:59:34-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 225M=0s 2015-12-07 19:59:34 (225 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.193134 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.144253) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.144569) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020339 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.194776) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.195158) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-07 19:59:35,084 truncating revision to first 12 chars 2015-12-07 19:59:35,084 Setting DEBUG logging. 2015-12-07 19:59:35,085 attempt 1/10 2015-12-07 19:59:35,085 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:35,400 unpacking tar archive at: fx-team-d08afef8b42d/testing/mozharness/ program finished with exit code 0 elapsedTime=0.642328 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.852900) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.853297) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.862648) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-07 19:59:34.863196) ========= 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.863831) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-07 19:59:34.864194) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 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-e10s --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-e10s', 19:59:35 INFO - 'system_bits': '64', 19:59:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 19:59:35 INFO - 'title': 'talos-linux64-ix-055', 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:36 INFO - Running post-action listener: _resource_record_post_action 19:59:36 INFO - ##### 19:59:36 INFO - ##### Running read-buildbot-config step. 19:59:36 INFO - ##### 19:59:36 INFO - Running pre-action listener: _resource_record_pre_action 19:59:36 INFO - Running main action method: read_buildbot_config 19:59:36 INFO - Using buildbot properties: 19:59:36 INFO - { 19:59:36 INFO - "properties": { 19:59:36 INFO - "buildnumber": 547, 19:59:36 INFO - "product": "firefox", 19:59:36 INFO - "script_repo_revision": "production", 19:59:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 19:59:36 INFO - "repository": "", 19:59:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 19:59:36 INFO - "buildid": "20151207183825", 19:59:36 INFO - "slavename": "talos-linux64-ix-055", 19:59:36 INFO - "pgo_build": "False", 19:59:36 INFO - "basedir": "/builds/slave/test", 19:59:36 INFO - "project": "", 19:59:36 INFO - "platform": "ubuntu64_hw", 19:59:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 19:59:36 INFO - "slavebuilddir": "test", 19:59:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 19:59:36 INFO - "branch": "fx-team", 19:59:36 INFO - "repo_path": "integration/fx-team", 19:59:36 INFO - "stage_platform": "linux64", 19:59:36 INFO - "builduid": "582424eae2754e808b005dab9f10399e", 19:59:36 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:36 INFO - }, 19:59:36 INFO - "sourcestamp": { 19:59:36 INFO - "repository": "", 19:59:36 INFO - "hasPatch": false, 19:59:36 INFO - "project": "", 19:59:36 INFO - "branch": "fx-team-linux64-talos", 19:59:36 INFO - "changes": [ 19:59:36 INFO - { 19:59:36 INFO - "category": null, 19:59:36 INFO - "files": [ 19:59:36 INFO - { 19:59:36 INFO - "url": null, 19:59:36 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:36 INFO - } 19:59:36 INFO - ], 19:59:36 INFO - "repository": "", 19:59:36 INFO - "rev": "d08afef8b42d1f481dc5f9cca8df35ed0a848836", 19:59:36 INFO - "who": "philringnalda@gmail.com", 19:59:36 INFO - "when": 1449547111, 19:59:36 INFO - "number": 7016645, 19:59:36 INFO - "comments": "Bug 1162813: filter paragraph separators before passing text to SetPara, r=jfkthame", 19:59:36 INFO - "project": "", 19:59:36 INFO - "at": "Mon 07 Dec 2015 19:58:31", 19:59:36 INFO - "branch": "fx-team-linux64-talos", 19:59:36 INFO - "revlink": "", 19:59:36 INFO - "properties": [ 19:59:36 INFO - [ 19:59:36 INFO - "buildid", 19:59:36 INFO - "20151207183825", 19:59:36 INFO - "Change" 19:59:36 INFO - ], 19:59:36 INFO - [ 19:59:36 INFO - "builduid", 19:59:36 INFO - "582424eae2754e808b005dab9f10399e", 19:59:36 INFO - "Change" 19:59:36 INFO - ], 19:59:36 INFO - [ 19:59:36 INFO - "pgo_build", 19:59:36 INFO - "False", 19:59:36 INFO - "Change" 19:59:36 INFO - ] 19:59:36 INFO - ], 19:59:36 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:36 INFO - } 19:59:36 INFO - ], 19:59:36 INFO - "revision": "d08afef8b42d1f481dc5f9cca8df35ed0a848836" 19:59:36 INFO - } 19:59:36 INFO - } 19:59:36 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:36 INFO - Running post-action listener: _resource_record_post_action 19:59:36 INFO - ##### 19:59:36 INFO - ##### Running download-and-extract step. 19:59:36 INFO - ##### 19:59:36 INFO - Running pre-action listener: _resource_record_pre_action 19:59:36 INFO - Running main action method: download_and_extract 19:59:36 INFO - mkdir: /builds/slave/test/build/tests 19:59:36 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:36 INFO - https://queue.taskcluster.net/v1/task/unRCPlr-RACK9L0f5-E0AQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 19:59:36 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:36 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:36 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:36 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:37 INFO - Downloaded 1302 bytes. 19:59:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 19:59:37 INFO - Using the following test package requirements: 19:59:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 19:59:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'jsshell-linux-x86_64.zip'], 19:59:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 19:59:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 19:59:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 19:59:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 19:59:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 19:59:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 19:59:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 19:59:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 19:59:37 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:37 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:37 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:37 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:37 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:37 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:38 INFO - Downloaded 21860240 bytes. 19:59:38 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:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 19:59:38 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:39 INFO - Return code: 0 19:59:39 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:39 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:39 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:39 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:39 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:39 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:39 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 - 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.talos.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.talos.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.talos.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.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.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.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:43 INFO - Downloaded 11132074 bytes. 19:59:43 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:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 19:59:43 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:43 INFO - Return code: 0 19:59:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:43 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:43 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:43 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:43 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:43 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:44 INFO - Downloaded 57728703 bytes. 19:59:44 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:44 INFO - mkdir: /builds/slave/test/properties 19:59:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 19:59:44 INFO - Writing to file /builds/slave/test/properties/build_url 19:59:44 INFO - Contents: 19:59:44 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:44 INFO - Running post-action listener: _resource_record_post_action 19:59:44 INFO - Running post-action listener: set_extra_try_arguments 19:59:44 INFO - ##### 19:59:44 INFO - ##### Running populate-webroot step. 19:59:44 INFO - ##### 19:59:44 INFO - Running pre-action listener: _resource_record_pre_action 19:59:44 INFO - Running main action method: populate_webroot 19:59:44 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 19:59:44 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 19:59:44 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 19:59:44 INFO - '../fennec_ids.txt'], 19:59:44 INFO - 'tests': ['tcheck2']}, 19:59:44 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 19:59:44 INFO - '--tppagecycles', 19:59:44 INFO - '7'], 19:59:44 INFO - 'tests': ['tsvgm']}}, 19:59:44 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 19:59:44 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tresize', 'tcanvasmark']}, 19:59:44 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:44 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 19:59:44 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:44 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 19:59:44 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['damp', 'tps']}, 19:59:44 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['damp', 'tps']}, 19:59:44 INFO - 'g3': {'tests': ['dromaeo_dom']}, 19:59:44 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 19:59:44 INFO - 'other': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other_l64': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'other_nol64': {'tests': ['a11yr', 19:59:44 INFO - 'ts_paint', 19:59:44 INFO - 'tpaint', 19:59:44 INFO - 'sessionrestore', 19:59:44 INFO - 'sessionrestore_no_auto_restore']}, 19:59:44 INFO - 'svgr': {'tests': ['tsvgx', 19:59:44 INFO - 'tsvgr_opacity', 19:59:44 INFO - 'tart', 19:59:44 INFO - 'tscrollx', 19:59:44 INFO - 'cart']}, 19:59:44 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tsvgx', 19:59:44 INFO - 'tsvgr_opacity', 19:59:44 INFO - 'tart', 19:59:44 INFO - 'tscrollx', 19:59:44 INFO - 'cart']}, 19:59:44 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'tests': ['tp5o']}, 19:59:44 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s'], 19:59:44 INFO - 'tests': ['tp5o']}, 19:59:44 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--xperf_path', 19:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:44 INFO - 'tests': ['tp5n']}, 19:59:44 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 19:59:44 INFO - 'talos_options': ['--e10s', 19:59:44 INFO - '--xperf_path', 19:59:44 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 19:59:44 INFO - 'tests': ['tp5n']}}, 19:59:44 INFO - 'talos.zip': {'path': '', 19:59:44 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 19:59:44 INFO - Running post-action listener: _resource_record_post_action 19:59:44 INFO - ##### 19:59:44 INFO - ##### Running create-virtualenv step. 19:59:44 INFO - ##### 19:59:44 INFO - Running pre-action listener: _resource_record_pre_action 19:59:44 INFO - Running main action method: create_virtualenv 19:59:44 INFO - Creating virtualenv /builds/slave/test/build/venv 19:59:44 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:44 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 19:59:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 19:59:45 INFO - Using real prefix '/usr' 19:59:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 19:59:45 INFO - Installing distribute.............................................................................................................................................................................................done. 19:59:47 INFO - Installing pip.................done. 19:59:47 INFO - Return code: 0 19:59:47 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 19:59:47 INFO - 'HOME': '/home/cltbld', 19:59:47 INFO - 'LANG': 'en_US.UTF-8', 19:59:47 INFO - 'LANGUAGE': 'en_US:en', 19:59:47 INFO - 'LOGNAME': 'cltbld', 19:59:47 INFO - 'MAIL': '/var/mail/cltbld', 19:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:47 INFO - 'MOZ_NO_REMOTE': '1', 19:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:47 INFO - 'NO_EM_RESTART': '1', 19:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:47 INFO - 'PWD': '/builds/slave/test', 19:59:47 INFO - 'SHELL': '/bin/bash', 19:59:47 INFO - 'SHLVL': '1', 19:59:47 INFO - 'TERM': 'linux', 19:59:47 INFO - 'TMOUT': '86400', 19:59:47 INFO - 'USER': 'cltbld', 19:59:47 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 19:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:47 INFO - '_': '/tools/buildbot/bin/python'} 19:59:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:47 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:47 INFO - Cleaning up... 19:59:47 INFO - Return code: 0 19:59:47 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:47 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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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:47 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:47 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:47 INFO - Using env: {'DISPLAY': ':0', 19:59:47 INFO - 'HOME': '/home/cltbld', 19:59:47 INFO - 'LANG': 'en_US.UTF-8', 19:59:47 INFO - 'LANGUAGE': 'en_US:en', 19:59:47 INFO - 'LOGNAME': 'cltbld', 19:59:47 INFO - 'MAIL': '/var/mail/cltbld', 19:59:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:47 INFO - 'MOZ_NO_REMOTE': '1', 19:59:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:47 INFO - 'NO_EM_RESTART': '1', 19:59:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:47 INFO - 'PWD': '/builds/slave/test', 19:59:47 INFO - 'SHELL': '/bin/bash', 19:59:47 INFO - 'SHLVL': '1', 19:59:47 INFO - 'TERM': 'linux', 19:59:47 INFO - 'TMOUT': '86400', 19:59:47 INFO - 'USER': 'cltbld', 19:59:47 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 19:59:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:47 INFO - '_': '/tools/buildbot/bin/python'} 19:59:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:48 INFO - Downloading/unpacking psutil>=0.7.1 19:59:48 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:48 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:48 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:48 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:48 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:48 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:49 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 19:59:49 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:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 19:59:49 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:49 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:49 INFO - Installing collected packages: psutil 19:59:49 INFO - Running setup.py install for psutil 19:59:49 INFO - building 'psutil._psutil_linux' extension 19:59:49 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:50 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:50 INFO - building 'psutil._psutil_posix' extension 19:59:50 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:50 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:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 19:59:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 19:59:50 INFO - Successfully installed psutil 19:59:50 INFO - Cleaning up... 19:59:50 INFO - Return code: 0 19:59:50 INFO - Installing mozsystemmonitor==0.0.0 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', '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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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', 'mozsystemmonitor==0.0.0'] 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 mozsystemmonitor==0.0.0 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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 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 - Downloading/unpacking mozsystemmonitor==0.0.0 19:59:50 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:50 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:50 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:50 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:50 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:50 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 - Downloading mozsystemmonitor-0.0.tar.gz 19:59:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 19:59:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 19:59:52 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:52 INFO - Installing collected packages: mozsystemmonitor 19:59:52 INFO - Running setup.py install for mozsystemmonitor 19:59:52 INFO - Successfully installed mozsystemmonitor 19:59:52 INFO - Cleaning up... 19:59:52 INFO - Return code: 0 19:59:52 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 19:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 19:59:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 19:59:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 19:59:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 19:59:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 19:59:52 INFO - Using env: {'DISPLAY': ':0', 19:59:52 INFO - 'HOME': '/home/cltbld', 19:59:52 INFO - 'LANG': 'en_US.UTF-8', 19:59:52 INFO - 'LANGUAGE': 'en_US:en', 19:59:52 INFO - 'LOGNAME': 'cltbld', 19:59:52 INFO - 'MAIL': '/var/mail/cltbld', 19:59:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 19:59:52 INFO - 'MOZ_NO_REMOTE': '1', 19:59:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 19:59:52 INFO - 'NO_EM_RESTART': '1', 19:59:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 19:59:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 19:59:52 INFO - 'PWD': '/builds/slave/test', 19:59:52 INFO - 'SHELL': '/bin/bash', 19:59:52 INFO - 'SHLVL': '1', 19:59:52 INFO - 'TERM': 'linux', 19:59:52 INFO - 'TMOUT': '86400', 19:59:52 INFO - 'USER': 'cltbld', 19:59:52 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 19:59:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:52 INFO - '_': '/tools/buildbot/bin/python'} 19:59:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:52 INFO - Downloading/unpacking blobuploader==1.2.4 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 19:59:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 19:59:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 19:59:54 INFO - Downloading blobuploader-1.2.4.tar.gz 19:59:54 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:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 19:59:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 19:59:54 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:54 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:54 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:54 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:54 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:54 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:54 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:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 19:59:54 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 19:59:54 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:54 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:54 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:54 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:54 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:54 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 docopt-0.6.1.tar.gz 19:59:55 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:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 19:59:55 INFO - Installing collected packages: blobuploader, requests, docopt 19:59:55 INFO - Running setup.py install for blobuploader 19:59:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 19:59:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 19:59:55 INFO - Running setup.py install for requests 19:59:55 INFO - Running setup.py install for docopt 19:59:55 INFO - Successfully installed blobuploader requests docopt 19:59:55 INFO - Cleaning up... 19:59:55 INFO - Return code: 0 19:59:55 INFO - Installing None 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', '--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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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', '--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:55 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: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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 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 - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:55 INFO - Running setup.py (path:/tmp/pip-4kwB4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:56 INFO - Running setup.py (path:/tmp/pip-P_UnJH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:56 INFO - Running setup.py (path:/tmp/pip-W8JC6g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:56 INFO - Running setup.py (path:/tmp/pip-Hh6EJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:56 INFO - Running setup.py (path:/tmp/pip-toTCCv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:56 INFO - Running setup.py (path:/tmp/pip-8xMjHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:56 INFO - Running setup.py (path:/tmp/pip-GCJIpL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:56 INFO - Running setup.py (path:/tmp/pip-gvPT15-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:56 INFO - Running setup.py (path:/tmp/pip-vpEp05-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:56 INFO - Running setup.py (path:/tmp/pip-3pTzNP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:56 INFO - Running setup.py (path:/tmp/pip-WdSiKc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:56 INFO - Running setup.py (path:/tmp/pip-IW8WMm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 19:59:56 INFO - Running setup.py (path:/tmp/pip-QIxthD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 19:59:56 INFO - Running setup.py (path:/tmp/pip-x7nvTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 19:59:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:56 INFO - Running setup.py (path:/tmp/pip-YX7mpP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 19:59:57 INFO - Running setup.py (path:/tmp/pip-sEJ5Mw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 19:59:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 19:59:57 INFO - Running setup.py (path:/tmp/pip-f01WcK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 19:59:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 19:59:57 INFO - Running setup.py install for manifestparser 19:59:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Running setup.py install for mozcrash 19:59:57 INFO - Running setup.py install for mozdebug 19:59:57 INFO - Running setup.py install for mozdevice 19:59:57 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Installing dm script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Running setup.py install for mozfile 19:59:57 INFO - Running setup.py install for mozhttpd 19:59:57 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Running setup.py install for mozinfo 19:59:57 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Running setup.py install for mozInstall 19:59:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 19:59:57 INFO - Running setup.py install for mozleak 19:59:58 INFO - Running setup.py install for mozlog 19:59:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Running setup.py install for moznetwork 19:59:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Running setup.py install for mozprocess 19:59:58 INFO - Running setup.py install for mozprofile 19:59:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Running setup.py install for mozrunner 19:59:58 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Running setup.py install for mozscreenshot 19:59:58 INFO - Running setup.py install for moztest 19:59:58 INFO - Running setup.py install for mozversion 19:59:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 19:59:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 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', '--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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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', '--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 --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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 19:59:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 19:59:58 INFO - '_': '/tools/buildbot/bin/python'} 19:59:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 19:59:59 INFO - Running setup.py (path:/tmp/pip-6dhjve-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 19:59:59 INFO - Running setup.py (path:/tmp/pip-sNFYIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 19:59:59 INFO - Running setup.py (path:/tmp/pip-w0jhiU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 19:59:59 INFO - Running setup.py (path:/tmp/pip-2ikij8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 19:59:59 INFO - Running setup.py (path:/tmp/pip-PJpCtf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 19:59:59 INFO - Running setup.py (path:/tmp/pip-ZX9xPb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 19:59:59 INFO - Running setup.py (path:/tmp/pip-0xFM0Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 19:59:59 INFO - Running setup.py (path:/tmp/pip-ZvSNRM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 19:59:59 INFO - Running setup.py (path:/tmp/pip-af0r8B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 19:59:59 INFO - Running setup.py (path:/tmp/pip-e9Wx2m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 19:59:59 INFO - Running setup.py (path:/tmp/pip-NhOMlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 19:59:59 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 19:59:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 19:59:59 INFO - Running setup.py (path:/tmp/pip-knbUHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:00:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:00:00 INFO - Running setup.py (path:/tmp/pip-w97oOg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:00:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:00:00 INFO - Running setup.py (path:/tmp/pip-elOnUk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:00:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:00 INFO - Running setup.py (path:/tmp/pip-GPpV3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:00:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:00:00 INFO - Running setup.py (path:/tmp/pip-gRvoQK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:00:00 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:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:00:00 INFO - Running setup.py (path:/tmp/pip-dc_Kb9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:00:00 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:00 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:00 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:00 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:00 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:00 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:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:02 INFO - Downloading blessings-1.5.1.tar.gz 20:00:02 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:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:00:02 INFO - Installing collected packages: blessings 20:00:02 INFO - Running setup.py install for blessings 20:00:02 INFO - Successfully installed blessings 20:00:02 INFO - Cleaning up... 20:00:02 INFO - Return code: 0 20:00:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:00:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:02 INFO - Reading from file tmpfile_stdout 20:00:02 INFO - Current package versions: 20:00:02 INFO - argparse == 1.2.1 20:00:02 INFO - blessings == 1.5.1 20:00:02 INFO - blobuploader == 1.2.4 20:00:02 INFO - docopt == 0.6.1 20:00:02 INFO - manifestparser == 1.1 20:00:02 INFO - mozInstall == 1.12 20:00:02 INFO - mozcrash == 0.16 20:00:02 INFO - mozdebug == 0.1 20:00:02 INFO - mozdevice == 0.47 20:00:02 INFO - mozfile == 1.2 20:00:02 INFO - mozhttpd == 0.7 20:00:02 INFO - mozinfo == 0.9 20:00:02 INFO - mozleak == 0.1 20:00:02 INFO - mozlog == 3.1 20:00:02 INFO - moznetwork == 0.27 20:00:02 INFO - mozprocess == 0.22 20:00:02 INFO - mozprofile == 0.27 20:00:02 INFO - mozrunner == 6.11 20:00:02 INFO - mozscreenshot == 0.1 20:00:02 INFO - mozsystemmonitor == 0.0 20:00:02 INFO - moztest == 0.7 20:00:02 INFO - mozversion == 1.4 20:00:02 INFO - psutil == 3.1.1 20:00:02 INFO - requests == 1.2.3 20:00:02 INFO - wsgiref == 0.1.2 20:00:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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:02 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:02 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:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 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:02 INFO - Cleaning up... 20:00:02 INFO - Return code: 0 20:00:02 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 20:00:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:00:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:00:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 20:00:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 20:00:02 INFO - Using env: {'DISPLAY': ':0', 20:00:02 INFO - 'HOME': '/home/cltbld', 20:00:02 INFO - 'LANG': 'en_US.UTF-8', 20:00:02 INFO - 'LANGUAGE': 'en_US:en', 20:00:02 INFO - 'LOGNAME': 'cltbld', 20:00:02 INFO - 'MAIL': '/var/mail/cltbld', 20:00:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:02 INFO - 'MOZ_NO_REMOTE': '1', 20:00:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:02 INFO - 'NO_EM_RESTART': '1', 20:00:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:02 INFO - 'PWD': '/builds/slave/test', 20:00:02 INFO - 'SHELL': '/bin/bash', 20:00:02 INFO - 'SHLVL': '1', 20:00:02 INFO - 'TERM': 'linux', 20:00:02 INFO - 'TMOUT': '86400', 20:00:02 INFO - 'USER': 'cltbld', 20:00:02 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 20:00:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:02 INFO - '_': '/tools/buildbot/bin/python'} 20:00:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:00:03 INFO - Downloading/unpacking jsonschema 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 jsonschema-2.5.1-py2.py3-none-any.whl 20:00:04 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:04 INFO - Downloading/unpacking functools32 (from jsonschema) 20:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:00:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:00:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:00:04 INFO - Downloading functools32-3.2.3-2.tar.gz 20:00:04 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:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:00:04 INFO - warning: no files found matching '*.txt' 20:00:04 INFO - no previously-included directories found matching 'build' 20:00:04 INFO - no previously-included directories found matching 'dist' 20:00:04 INFO - no previously-included directories found matching '.git*' 20:00:04 INFO - Installing collected packages: jsonschema, functools32 20:00:05 INFO - Running setup.py install for functools32 20:00:05 INFO - warning: no files found matching '*.txt' 20:00:05 INFO - no previously-included directories found matching 'build' 20:00:05 INFO - no previously-included directories found matching 'dist' 20:00:05 INFO - no previously-included directories found matching '.git*' 20:00:05 INFO - Successfully installed jsonschema functools32 20:00:05 INFO - Cleaning up... 20:00:05 INFO - Return code: 0 20:00:05 INFO - Installing flake8 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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fe2c4745f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x22c58a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2393240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, '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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', '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', 'flake8'] 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 flake8 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': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 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 flake8 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 flake8-2.5.0-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%2Fflake8-2.5.0-py2.py3-none-any.whl 20:00:07 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 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 mccabe-0.3.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%2Fmccabe-0.3.1-py2.py3-none-any.whl 20:00:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 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 - 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:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 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 - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 20:00:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:07 INFO - no previously-included directories found matching 'docs/_build' 20:00:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 20:00:07 INFO - Running setup.py install for pep8 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 20:00:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 20:00:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 20:00:07 INFO - no previously-included directories found matching 'docs/_build' 20:00:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 20:00:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 20:00:07 INFO - Cleaning up... 20:00:07 INFO - Return code: 0 20:00:07 INFO - Running post-action listener: _resource_record_post_action 20:00:07 INFO - Running post-action listener: _start_resource_monitoring 20:00:07 INFO - Starting resource monitoring. 20:00:07 INFO - ##### 20:00:07 INFO - ##### Running install step. 20:00:07 INFO - ##### 20:00:07 INFO - Running pre-action listener: _resource_record_pre_action 20:00:07 INFO - Running main action method: install 20:00:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:00:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:00:08 INFO - Reading from file tmpfile_stdout 20:00:08 INFO - Detecting whether we're running mozinstall >=1.0... 20:00:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:00:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:00:08 INFO - Reading from file tmpfile_stdout 20:00:08 INFO - Output received: 20:00:08 INFO - Usage: mozinstall [options] installer 20:00:08 INFO - Options: 20:00:08 INFO - -h, --help show this help message and exit 20:00:08 INFO - -d DEST, --destination=DEST 20:00:08 INFO - Directory to install application into. [default: 20:00:08 INFO - "/builds/slave/test"] 20:00:08 INFO - --app=APP Application being installed. [default: firefox] 20:00:08 INFO - mkdir: /builds/slave/test/build/application 20:00:08 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:08 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:23 INFO - Reading from file tmpfile_stdout 20:00:23 INFO - Output received: 20:00:23 INFO - /builds/slave/test/build/application/firefox/firefox 20:00:23 INFO - Running post-action listener: _resource_record_post_action 20:00:23 INFO - ##### 20:00:23 INFO - ##### Running run-tests step. 20:00:23 INFO - ##### 20:00:23 INFO - Running pre-action listener: _resource_record_pre_action 20:00:23 INFO - Running main action method: run_tests 20:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:00:23 INFO - Python 2.7.3 20:00:23 INFO - Return code: 0 20:00:23 INFO - grabbing minidump binary from tooltool 20:00:23 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:23 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 0x24220b0>, '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 0x2422fb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2423440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:00:23 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:23 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:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:00:23 INFO - Return code: 0 20:00:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 20:00:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:00:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:00:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 20:00:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:00:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 20:00:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 20:00:24 INFO - Return code: 0 20:00:24 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-e10s', '--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-055', '--webServer', 'localhost'] in /builds/slave/test/build 20:00:24 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-e10s --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-055 --webServer localhost 20:00:24 INFO - Using env: {'DISPLAY': ':0', 20:00:24 INFO - 'HOME': '/home/cltbld', 20:00:24 INFO - 'LANG': 'en_US.UTF-8', 20:00:24 INFO - 'LANGUAGE': 'en_US:en', 20:00:24 INFO - 'LOGNAME': 'cltbld', 20:00:24 INFO - 'MAIL': '/var/mail/cltbld', 20:00:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:00:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 20:00:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:00:24 INFO - 'MOZ_NO_REMOTE': '1', 20:00:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:00:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 20:00:24 INFO - 'NO_EM_RESTART': '1', 20:00:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 20:00:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:00:24 INFO - 'PWD': '/builds/slave/test', 20:00:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:00:24 INFO - 'SHELL': '/bin/bash', 20:00:24 INFO - 'SHLVL': '1', 20:00:24 INFO - 'TERM': 'linux', 20:00:24 INFO - 'TMOUT': '86400', 20:00:24 INFO - 'USER': 'cltbld', 20:00:24 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308', 20:00:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:00:24 INFO - '_': '/tools/buildbot/bin/python'} 20:00:24 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-e10s', '--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-055', '--webServer', 'localhost'] with output_timeout 3600 20:00:24 INFO - mozversion INFO | application_buildid: 20151207183825 20:00:24 INFO - mozversion INFO | application_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 20:00:24 INFO - mozversion INFO | application_display_name: Nightly 20:00:24 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:00:24 INFO - mozversion INFO | application_name: Firefox 20:00:24 INFO - mozversion INFO | application_remotingname: firefox 20:00:24 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 20:00:24 INFO - mozversion INFO | application_vendor: Mozilla 20:00:24 INFO - mozversion INFO | application_version: 45.0a1 20:00:24 INFO - mozversion INFO | platform_buildid: 20151207183825 20:00:24 INFO - mozversion INFO | platform_changeset: d08afef8b42d1f481dc5f9cca8df35ed0a848836 20:00:24 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 20:00:24 INFO - mozversion INFO | platform_version: 45.0a1 20:00:24 INFO - 2015-12-07 20:00:24,435 DEBUG : using testdate: 1449547224 20:00:24 INFO - 2015-12-07 20:00:24,435 DEBUG : actual date: 1449547224 20:00:24 INFO - 2015-12-07 20:00:24,537 INFO : starting webserver on 'localhost:55781' 20:00:24 INFO - 2015-12-07 20:00:24,538 INFO : Starting test suite talos-linux64-ix-055.e 20:00:24 INFO - 2015-12-07 20:00:24,538 INFO : Starting test dromaeo_css 20:00:24 INFO - 2015-12-07 20:00:24,538 DEBUG : operating with platform_type : linux_ 20:00:24 INFO - 2015-12-07 20:00:24,539 INFO : Initialising browser for dromaeo_css test... 20:00:24 INFO - 2015-12-07 20:00:24,554 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2pqD_C/profile http://localhost:55781/getInfo.html 20:00:29 INFO - 2015-12-07 20:00:29,457 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:00:29 INFO - 2015-12-07 20:00:29,457 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:00:29 INFO - 2015-12-07 20:00:29,457 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:00:29 INFO - 2015-12-07 20:00:29,458 DEBUG : BROWSER_OUTPUT: __metrics 20:00:29 INFO - 2015-12-07 20:00:29,574 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:30 INFO - 2015-12-07 20:00:30,457 INFO : Browser initialized. 20:00:30 INFO - 2015-12-07 20:00:30,457 INFO : Running cycle 1/1 for dromaeo_css test... 20:00:30 INFO - 2015-12-07 20:00:30,458 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2pqD_C/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:00:42 INFO - 2015-12-07 20:00:42,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 142946304 20:00:42 INFO - 2015-12-07 20:00:42,497 DEBUG : BROWSER_OUTPUT: 20:01:32 INFO - 2015-12-07 20:01:32,135 DEBUG : BROWSER_OUTPUT: 1449547292131 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:43 INFO - 2015-12-07 20:03:43,934 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-dojo.html (next: http://localhost:55781/tests/dromaeo/cssquery-ext.html) 20:03:45 INFO - 2015-12-07 20:03:45,123 DEBUG : BROWSER_OUTPUT: RSS: Main: 144281600 20:03:45 INFO - 2015-12-07 20:03:45,123 DEBUG : BROWSER_OUTPUT: 20:06:47 INFO - 2015-12-07 20:06:47,231 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-ext.html (next: http://localhost:55781/tests/dromaeo/cssquery-jquery.html) 20:06:47 INFO - 2015-12-07 20:06:47,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 143925248 20:06:47 INFO - 2015-12-07 20:06:47,820 DEBUG : BROWSER_OUTPUT: 20:09:49 INFO - 2015-12-07 20:09:49,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-jquery.html (next: http://localhost:55781/tests/dromaeo/cssquery-mootools.html) 20:09:50 INFO - 2015-12-07 20:09:50,243 DEBUG : BROWSER_OUTPUT: RSS: Main: 145035264 20:09:50 INFO - 2015-12-07 20:09:50,243 DEBUG : BROWSER_OUTPUT: 20:12:52 INFO - 2015-12-07 20:12:52,012 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-mootools.html (next: http://localhost:55781/tests/dromaeo/cssquery-prototype.html) 20:12:52 INFO - 2015-12-07 20:12:52,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 144523264 20:12:52 INFO - 2015-12-07 20:12:52,619 DEBUG : BROWSER_OUTPUT: 20:15:55 INFO - 2015-12-07 20:15:55,267 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-prototype.html (next: http://localhost:55781/tests/dromaeo/cssquery-yui.html) 20:15:55 INFO - 2015-12-07 20:15:55,893 DEBUG : BROWSER_OUTPUT: RSS: Main: 144285696 20:15:55 INFO - 2015-12-07 20:15:55,893 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,205 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/dromaeo/cssquery-yui.html (next: http://localhost:55781/tests/dromaeo/cssquery-dojo.html) 20:18:58 INFO - 2015-12-07 20:18:58,455 DEBUG : BROWSER_OUTPUT: RSS: Main: 147329024 20:18:58 INFO - 2015-12-07 20:18:58,455 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,457 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:18:58 INFO - 2015-12-07 20:18:58,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:18:58 INFO - 2015-12-07 20:18:58,457 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:18:58 INFO - 2015-12-07 20:18:58,457 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:18:58 INFO - 2015-12-07 20:18:58,460 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2680.9195724128276;2698.9460210795796;2745.7117002714713;2752.174347695691;2764.7235276472347;4616.884577885555;4763.4522029966565;4768.046390721856;4788.569028787409;4820.228763397857;4641.303804429329;4665.370175026379;4692.6245900327895;4800.111979283826;4813.66304358695;4343.609075183233;4398.450193725785;4514.390557274759;4516.051629157864;4555.74943378114;4392.341148827685;4448.510663826976;4464.2187617166865;4500.684952053358;4597.977010114945;4235.449391579075;4482.731036137842;4513.7066090704;4539.114872599845;4548.090381923628;4268.210381079511;4292.29177185764;4329.545397733255;4338.262495375794;4345.565443455661;4368.453943257093;4385.166818304512;4386.714863533892;4404.955950440487;4449.3548435477;4563.794629241659;4707.8587642370785;4708.505606911259;4725.5510726480925;4740.5733483986605;5013.774380152902;5092.083424983502;5111.923321150186;5116.360454943132;5145.33110695611;5074.13739664258;5100.69395836251;5110.514501122388;5118.820841270538;5133.6149788765615;4636.211843986531;4643.628509719214;4718.976405117953;4725.267583524559;4730.62155027597;5266.578673706094;5276.604254680914;5277.683338999673;5285.788568457296;5305.8938821223355;5042.067217564762;5055.797768089235;5058.696478211319;5061.493850614983;5110.48895110486;4869.683470574401;4987.351644286292;5001.824936127218;5117.257997590328;5141.511556402136;5020.874478138076;5023.748812559431;5032.144535428986;5040.143175660147;5089.465606111379;5012.448630650625;5086.796528138833;5092.414372347153;5095.388553373545;5100.668456550312;4111.444954931106;4189.455370801777;4230.809613567397;4297.333913243452;4344.9348259776125;3761.1161377076915;3777.036855601804;3788.1287303920253;3812.294725475796;3824.541055073409;4254.957450425518;4409.5149533551285;4427.933580996288;4436.911261774811;4442.755648439367;4989.401271847329;4992.126377883928;5027.723475208825;5030.4215015272985;5066.417362003417;4380.605745482858;4389;4397.956020439755;4403.229434848889;4427.5572442755465;4398.362237475548;4496.550344965477;4566.06395688883;4573.131105090089;4610.677252592286;4711.31685905535;4738.881527961828;4763.309320148628;4784.617230621542;4828;5118.129917914038;5162.148245539444;5170.069387510284;5173.948260517347;5220.9216861746345;4836.854894353034;4846.442659094249;4857.489963553776;4859.854204373874;4906.681065730716;4815.542523460265;4907.509249075064;4914.65597408178;5004.074246264453;5047.066292735855;5133.281340612242;5138.3833939927445;5140.177571588528;5145.665531740575;5203.401608814884;4777.211760059551;4976.129177394014;5016;5021.422536408214;5022.924656130088;4914.655974081923;4938.506149385033;4952.975235123801;4975.825846095369;5033.119204139334;4888.902221955612;4889.413270407432;4923.08922849274;4944.604431645532;4959.950400495949;4720.622350211906;5037.546620804145;5054.368203974504;5083.313752643346;5108.56577190943;4785;4788.377510923558;4818.156822555969;4839.975800120977;4871.3667223260745 20:18:58 INFO - 2015-12-07 20:18:58,461 DEBUG : BROWSER_OUTPUT: |1;ext.html;530.3423754544366;531.9202119682047;536.2090915899051;540.0225591679061;540.6296686769562;35169.82415087924;36056.45915311272;36108;36140.819295903515;36276;40492.59507404925;41069.38395924064;41137.17725645485;41179.38230926531;41221.7938910305;8067.273945344918;8136;8204.507729536217;8215.917840821605;8226.218509241642;7945.284924356807;8045.356371490267;8060.476069055492;8119.797005074861;8147.714829980951;8033.517988920654;8098.797530061766;8117;8135.552544610044;8143.470674406145;7934.563599002053;8009.599520023976;8045;8049.557274349909;8082.393820463489;8011.599420029033;8041.55771432571;8140.0638926523025;8162.428629995903;8167.101618821925;37116.628833711584;37498.625013749785;37576.812115939516;37650;37680.623193767984;2768.9446211075665;2790.260580946051;3076.2463196516774;3456.9827150864335;3467.2025434150287;27757;28041.71958280432;28225;28439;28569.285767855763;3261.1357990132633;3279.885204017848;3282.655321191264;3283.9014829555153;3313.2213929726495;215401.92299038562;215949;216606;216884;217960;38420.35006674418;54652.45347546553;55389.72305138529;55563.88797232301;55669;37001.444978325344;37262.46006629366;37341.62658373436;37342.62657373446;37521.81239093787;13254.602361929157;13341.266230357229;13541.796873046913;13578;13596.524121655695;10448.895511044791;10483.161347092215;10531.631392901212;10554.47227638615;10586.894131058745;12936.47738690965;13127.343632818322;13549.729005419837;13557.864421355858;13567.457301708018;5391.73041347931;5421.2952316199435;5452.863678408072;5517.2551705519245;5532.806351777668;780.7306479264645;872.6727477196051;893.2228960804142;895.5343221524771;1070.817960946641;26055;26135.869320653655;26203.475930481283;29141.56287655687;31160.688393116234;950.4059962523423;973.4062222044547;992.7815880506278;1019.2814066083394;1066.1524088349781;13373.732525349438;13449.529266475627;13480.730385392433;13661.316934153252;13663.863361366259;304753;309835;311015;311377;311494;47439.28841067387;47991.28013079806;48061;48161.277580836315;48304.7584762074;1201.2252097397304;1222.2238878312335;1222.7711150293899;1235.5366737473628;1239.2254840724547;25305.367365815266;25577.616335754607;25699.229023129337;25710;25828.35429114287;38065.4290185653;38505.42241866318;38621.80689096537;38706.0323491915;38837.6116238834;253782;254223;254369;254924;257024;29456.995875604636;29706.405871882875;30019.69980300169;30118.548221777128;30173.849130754206;38005.61994380021;38258;38453.230935381696;38962;39141.80429097836;33049.83475082609;33618;33733;33922;34212.82893585516;32913.67086329106;33610.663893360754;33698.326033478705;33737;33748.49377259294;37942;38099.42850857295;38686.419703703905;38771.806140969114;38990.220195595364;28018.85990570034;28267.293317667223;29212;30434;30434.239144021576;24143.879280603483;24333;25229.495410092062;26676.333091672088;26682.332941676614 20:18:58 INFO - 2015-12-07 20:18:58,462 DEBUG : BROWSER_OUTPUT: |2;jquery.html;281.8590704647676;283.71911807310755;285.96480739722205;286.38570266777765;287.83449516527986;12980.61058168254;13420.261885596288;14921.179335136563;15398.769018464718;15436.691266174685;9635.951820240907;10137.898621013788;10212.183025357972;14801.407943682267;15313.693726125472;4478.552144785528;4596.839110631128;4605.838795642137;4607.562281583244;4610.423697037871;4970.900581988358;4995.825146119886;5192.1432963560965;5200.375954885419;5201.271821944931;5084.694918304914;5145.485451454843;5160.2517634942915;5170.353705786777;5185.844424667266;5142.794288228466;5357.249985002103;5694.145878118274;5707.457791509779;5707.600467967244;5059.721715305656;5083.872903177413;5085.974570127163;5098.898022039575;5120.15517439622;11062.668119956414;11191.32852028881;17629.294828206857;19590.608187836162;19661.213551457924;1804.5218017225445;1843.4746097362188;1847.058000419782;1878.5585387433941;1937.0314842578712;8848.734537963872;8853.690120845804;8965.820683586357;8975.551222438851;9155;1678.613918798671;1707.2744083764474;1713.5459103337625;1723.9913800430918;1756.464278395089;54777.726111369586;55835.162472562944;56286.71856640732;56316.43683563153;57136.71431642815;9747.3664211826;9748.073932976356;9790.118889299854;9814;9857.260705447121;12327.445264963098;12343.753124937452;12352.07359448045;12358.814617780741;12371.195872268454;6909.343612356818;6943.79168624942;6965.930340696528;7041.260667629927;7206;6720.697568609425;6759.628220447923;6796.669631880442;6900.827479312957;6988.440924726111;4007.3332900395812;4013.3177359848896;4122.175564887035;4141.565135660772;4155.148194620096;1640.7949006374204;1641.433705371645;1660.7342825147919;1665.8667306615441;1709.2564734340601;845.5476320168681;847.6058632735808;864.4985908173245;967.2358836519071;989.4953573677476;15662.765058524132;15764.60588485297;15918.106971273732;16205.594860128354;16434.178291085398;833.7207035643128;845.7124577643508;848.1052489623506;852.6205838401852;855.2901092093548;8967.103289671111;9032.819343613091;9035.412698174598;9233.169014788702;9287.117723816227;446350;447474;451050;460171;461659;65754.67122664356;68196;68380;68425.65787171132;68691.65654171698;1032.8863824979246;1033.9017793309624;1042;1047.3192424923861;1055.5408397347178;14271.643208919444;14272.928635357172;14299.71400571962;14301.499447519287;15283;33662.495062573595;33963;34672.30655386928;34729.305413891074;35014.12464688403;40297.21721141418;40449;42140.367894482224;42412.575874240865;43145.568544314156;8828.779280518038;8989.146031127033;9045.592948317473;9081.636734530544;9115.22520585731;11378.943105284421;11959.581414650445;16325.67348653044;16460;16554;13429.865701343253;13535.323233838466;13859.30703464843;13861.930690346484;14433.134011959317;12924.483020679067;13169.407376668265;13657.248851313274;13760.724785504033;13926.860731392557;13300.800487992881;13450.46198152063;13486.12340197884;13653.590392288248;14030;8829.867551986597;8919.866202006846;8923;8977.416467929565;9013.729588112104;12870.292133932724;13909.513167039106;14142.363593638516;14191.787123193368;14243.715125697636 20:18:58 INFO - 2015-12-07 20:18:58,463 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1468.2878803780159;1655.7847479827624;1709.077098366882;1731.4026660802026;1738.3307426640743;5986.341502434729;6148.262208534971;6998.440124790018;7182.533135346199;7194.892076618855;6624.635645039521;6804.421624161952;6814.4548436125115;6839.2134904486;6846.623435711034;2022.2719820864513;2051.2615458434952;2059.742532183477;2063.0613071052635;2063.772984971652;2050.0467282713535;2064.1743302678974;2085.5828834233216;2093.5289559849066;2098.1187901081507;2013.224908410258;2016.3648450738044;2027.2397850805949;2040.010594861491;2047.5802460495638;2003.5191554027074;2019.4345583236643;2022.4337185588058;2030.1980717616607;2032.4410787033537;2022.1102714805586;2040.2553068130173;2063.0613071052635;2065.710800487933;2074.5747121839986;6925.480588955798;6930.653467326613;6935.029095926574;6955.6869940852785;6989.4408447324095;4083.448734420845;4131.814068366931;4149.6265336119895;4174.70777045607;4177.97911010443;2647.35139890728;2687.87904544296;2698.406350602864;2769.8476583788083;2770.8753106110275;850.5832142250315;864.4035615425399;864.4381152251025;874.1215078845783;886.5345693510894;9342.71971840839;9342.766430839216;9359.812803743887;9360.391574547633;9373.859392109192;3642.3625865473437;3689.2990331836863;3738.36447803874;3761.755485893408;3772.2266935278203;8156.225158609923;8185.427020108655;8188;8199.71301004462;8209.055958564722;4212.220739163265;4215.304474761691;4216.599423054805;4217.198732240864;4219.135077309144;3207.7273431758563;3320.4189266878197;3737.0470530014672;3849.2493963677375;3859.4017927221325;3389.49157626358;3404.0808981575333;3422.6064002640014;3424.143964008998;3434.8797792077658;1069.7806949575318;1070.4852633523633;1079.4710591810115;1081.6106201767357;1085.9565617375374;945.4469135555639;978.2565250409598;1164.5050853387277;1190.3453100794702;1196.4017991004498;6547.279799222082;6607.471402287805;6611.471082313404;6611.834704132339;6626.171728533934;1006.7080546641538;1049.3651340938775;1051.8790339111101;1063.4151216830867;1095.5179720922768;4986.601071914238;5036.748162591855;5037.672551284155;5045.369328833895;5046.091703493333;7962.56205908669;8017.559034253172;8105.959470202612;8220;8252.174782521699;8082.353411727047;8089.797755056053;8096.230858068592;8123.7156699515235;8175.836483270301;6584.2599536151965;6671.933280667131;6688.4649228061635;6691.26396096429;6706.228783689938;6294.055891616111;6318.810435686937;6346.428821406095;6376.553641245254;6390.680465976589;7410.036695229585;7555.962220188864;7685.654145563351;7710.190430004993;7765.922340776746;7715.884261735966;7762.184970578234;7806.258405451473;7862.803429914298;7921.603919804102;4765.714057156443;4841.975790121027;5701.686407247641;5792.4497172768515;5848.064309710596;6541.34586541342;6559.967200163968;6572.572782769104;6584.670766461753;6597.373249541286;5912.733926973383;6043.879122417615;6117.877642447215;6381.329960354096;6388.68056597159;5860.472557469848;6174.135621013152;6181.567290289637;6285.842853928689;6291.811245662638;6282.246130464374;6307.96846015767;6327.430531252209;6333.398327158912;6359.17330747;5721.027425337619;5722.599418040697;5734.569907257056;5740.13897915316;5751.626144300607;5781.161731548817;5804.303483581997;5853.09277062056;5863.912041319299;5864.413558644102 20:18:58 INFO - 2015-12-07 20:18:58,464 DEBUG : BROWSER_OUTPUT: |4;prototype.html;262.7083936830118;264.3088324032655;266.54287896257915;266.84122946846617;272.3708233979507;5621.662700237988;5630.465105814947;5666.631668941516;5710.314762228533;5832.300123985127;5636.605437619368;5674.773009079642;5681.005823980808;5684.573656975723;5693.202951586781;4084.407760874664;4187.267228235062;4191.748495090289;4197.685173611976;4199.3910882921955;4168.958310416902;4173.812178451977;4174.874753757392;4176.99752059505;4185.811638476261;4136.21411931732;4137.813798379065;4139.461869956901;4152.8131234094535;4190.057237121654;4183.644390226835;4183.832646694129;4189.141226048653;4190.308599081148;4193.769342686151;3420.555327807394;3461.16931936336;3515.8593656253975;3538.840752166133;3582.194006348551;5345.625806193568;5362;5363.383210930754;5368.087425137697;5385.623006389555;4754.239321708545;4756.881077973044;4758.738269395182;4766.142094423002;4772.164871147535;5833.06670932653;5836.503897168745;5849.502792262663;5854.912176317359;5883.470487656089;3728.9627103728885;3801.600831912637;3837.57786643469;3862.6909847212437;3879.8836034919;6168.074788781674;6217.875642487125;6219.968900155515;6222.066689996492;6234.9688251558455;3912.56961734209;3913.3934240192816;3914.0606254498716;3916.7258291919293;3928.8232029558167;3967.2263908538134;3979.303621866162;3981.124152686404;3983.7410568312966;3990.4413382126527;4596.4024676791805;4619.46876109245;4659.464161621389;4710.9764451177525;4747.169245382044;5902.439268269508;5904.7933322334375;5911.793087241926;5920.023196172583;5925.377835327315;1403.9087459315112;1415.801787749716;1416.9504067357593;1417.3267697843648;1419.7657386531107;912.119804388768;916.867054277126;917.7338571814232;935.695898832882;939.0656296984544;5132.10188217068;5143.588512918957;5158.484151584811;5161.638685291993;5172.456892026283;6152.230971128609;6168.136460895478;6180.196574445294;6190.690465476799;6194.194754681863;5137.8715532112;5143.871403214949;5155.175171972466;5160.819371321985;5171.741412929414;3209.1816586770224;3314.751393645486;3343.7993720376367;3344.247544302561;3357.8321083945707;5847.415258474119;5849.6782676952325;5853.970730146322;5861.0915308127305;5863.853403664943;6353.904691429632;6400.135981642512;6406.0390941359165;6411.455026322721;6414.390632889868;5667.1499275108235;5837.854053648693;5840.2991641003355;5841.912371314434;5843.152742852348;6203.565750397429;6215.036669316263;6216.595921265103;6227.688615569113;6229.190205273286;6086.056661217518;6090.634561926121;6093.116498107838;6094.238220222473;6105;5693.601447898607;5803.158542011469;5850.7074646266665;5865.765369385347;5875.823725288248;3965.385365268388;4019.4171845082883;4021.155557332993;4024.1951609678767;4030.979845100756;5921.496672782861;6095.878082438415;6233.283172435046;6234.3453937337745;6239.032949892774;5812.73842677089;5960.105984102246;5999.850003749767;6009.609375390585;6016.639001659914;5934.228550288608;5965.373635768182;5973.313068997121;5977.252843394575;5982.431668991613;5692.260006199168;5841.591088623755;5844.1525978732;5856.648601083949;5860.15027820955;6020.217371741645;6028.065649824284;6038.939610604013;6039.818805435844;6043.939560604514;5847.181394604844;5874.295084589877;5881.147233651182;5881.73532191061;5889.676067816311 20:18:58 INFO - 2015-12-07 20:18:58,464 DEBUG : BROWSER_OUTPUT: |5;yui.html;626.6240255846495;717.4439809147912;720.700909122714;776.1384862802289;784.3529088501983;11470.25443346182;11625.360605166712;11672.824907626382;11680.591179308725;11692.532298708064;11474.827877581843;11575.479103440344;11576.305421674706;11605.47775350109;11633.36016519091;607.0348146447149;608.8082254089969;773.7446642607925;774.8760198368262;785.2971590426565;787.7321710618388;789.0649580247397;789.763071078677;793.7301317552032;794.6543253684637;823.4853216739538;824.4805772363403;828.5732847583499;828.747232094211;830.244477525452;816.7304789419477;819.418213068719;819.942604017719;823.5840900345318;825.9793505162359;613.3437222172278;615.1142355008818;615.6552330694825;615.8583525789094;617.2870334763355;11169.553217871357;11201.551937922473;11224.102071834233;11230.382328971904;11237.943810280896;10989.780204395947;11557.653270401901;11565.595204167814;11573.189876708633;11878.762424751543;9488.193503552206;9491.322859348114;9510.28672849532;9523.19052880506;9553.187979021792;3250.073728987251;3251.5122731590213;3312.453445181566;3313.7349012078976;3381.509681096252;40903.7954810227;41474.79262603698;41681.79159104215;41727.791361043;41798.79100604508;9230.815383692288;9402;9447.385919915183;9530.809383812284;9589.280803939733;15524.844751552566;15768.132752698712;15833.841661583467;15861.920690396704;15869;6278.4035516625845;6392.648404337806;6466.321036291216;6500.349965003462;6604.3725846044545;3637;3716.9070773230346;3731.2350968051483;3800.3539398302355;3816.599257078022;2581.4707984863435;2592;2604.4660844526825;2608.817382783187;2621.895124195011;482.1081000149695;488.90955173293054;497.58948867184716;498.04375598850294;500.9499050095034;539.8245570189704;586.718375179916;597.0387675841891;613.2028363127915;641.1696852575925;8126.715564955198;8639.827203456021;8801.25189358899;8845.336599755045;9041.367104302768;493.1443944755846;501.2581379558274;559.7509108446784;582.7639805878626;590.1266126133261;3733.3466643337306;3771.2080463102507;3859.614038596118;3863.2273545291055;3919.3141200290406;43900;47874.28188577174;48620;48707.512924870294;48925.51074489281;41842.79078604587;41913.79043104765;42296.788516057226;42730.78634606807;43442.78278608587;38459.80770096132;38902.61097389046;40084.799576002515;40173.1965360697;40218.59781402207;7885.526868387915;7963.243491868263;7996.720114796187;7997.2083052917105;8298.502089874386;30529.38941221119;30761;31011.84494077515;31447;31671;34502.137446563036;34900.127496812784;34918.476222857185;36398.636013640586;38481.23037539177;10043.69868903934;10075.596976120873;10150.492475376053;10166.542505587415;10363.326383785332;10857.891421085687;11047.392393418439;11071.391073491035;11078.335299882034;11259.211855170059;10481.475926203508;10508.474576271308;10530.21023423231;10603.522841472306;10758.762742284738;10197.388156710622;10253.128484078938;10268.948655256676;10342.224333174892;10480.737981550523;10413.166946644402;10561.155107591529;10825.350478971286;10860.402677852793;11022.118230541697;9151.405158664666;9214.539273036455;9379;9494.287928405536;9632.006676336958;8864.955675221583;9092.272618190662;9118;9129.77175570616;9282.443053416817 20:18:58 INFO - 2015-12-07 20:18:58,464 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,323 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548338456__endTimestamp 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,465 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:18:58 INFO - 2015-12-07 20:18:58,466 DEBUG : BROWSER_OUTPUT: Number of tests: 6 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4706.86 Median:4815.54 stddev:485.30 (10.1%) stddev-sans-first:460.03 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: Values: 2680.9 2698.9 2745.7 2752.2 2764.7 4616.9 4763.5 4768.0 4788.6 4820.2 4641.3 4665.4 4692.6 4800.1 4813.7 4343.6 4398.5 4514.4 4516.1 4555.7 4392.3 4448.5 4464.2 4500.7 4598.0 4235.4 4482.7 4513.7 4539.1 4548.1 4268.2 4292.3 4329.5 4338.3 4345.6 4368.5 4385.2 4386.7 4405.0 4449.4 4563.8 4707.9 4708.5 4725.6 4740.6 5013.8 5092.1 5111.9 5116.4 5145.3 5074.1 5100.7 5110.5 5118.8 5133.6 4636.2 4643.6 4719.0 4725.3 4730.6 5266.6 5276.6 5277.7 5285.8 5305.9 5042.1 5055.8 5058.7 5061.5 5110.5 4869.7 4987.4 5001.8 5117.3 5141.5 5020.9 5023.7 5032.1 5040.1 5089.5 5012.4 5086.8 5092.4 5095.4 5100.7 4111.4 4189.5 4230.8 4297.3 4344.9 3761.1 3777.0 3788.1 3812.3 3824.5 4255.0 4409.5 4427.9 4436.9 4442.8 4989.4 4992.1 5027.7 5030.4 5066.4 4380.6 4389.0 4398.0 4403.2 4427.6 4398.4 4496.6 4566.1 4573.1 4610.7 4711.3 4738.9 4763.3 4784.6 4828.0 5118.1 5162.1 5170.1 5173.9 5220.9 4836.9 4846.4 4857.5 4859.9 4906.7 4815.5 4907.5 4914.7 5004.1 5047.1 5133.3 5138.4 5140.2 5145.7 5203.4 4777.2 4976.1 5016.0 5021.4 5022.9 4914.7 4938.5 4953.0 4975.8 5033.1 4888.9 4889.4 4923.1 4944.6 4960.0 4720.6 5037.5 5054.4 5083.3 5108.6 4785.0 4788.4 4818.2 4840.0 4871.4 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41352.10 Median:18834.91 stddev:68790.41 (365.2%) stddev-sans-first:68915.10 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: Values: 530.3 531.9 536.2 540.0 540.6 35169.8 36056.5 36108.0 36140.8 36276.0 40492.6 41069.4 41137.2 41179.4 41221.8 8067.3 8136.0 8204.5 8215.9 8226.2 7945.3 8045.4 8060.5 8119.8 8147.7 8033.5 8098.8 8117.0 8135.6 8143.5 7934.6 8009.6 8045.0 8049.6 8082.4 8011.6 8041.6 8140.1 8162.4 8167.1 37116.6 37498.6 37576.8 37650.0 37680.6 2768.9 2790.3 3076.2 3457.0 3467.2 27757.0 28041.7 28225.0 28439.0 28569.3 3261.1 3279.9 3282.7 3283.9 3313.2 215401.9 215949.0 216606.0 216884.0 217960.0 38420.4 54652.5 55389.7 55563.9 55669.0 37001.4 37262.5 37341.6 37342.6 37521.8 13254.6 13341.3 13541.8 13578.0 13596.5 10448.9 10483.2 10531.6 10554.5 10586.9 12936.5 13127.3 13549.7 13557.9 13567.5 5391.7 5421.3 5452.9 5517.3 5532.8 780.7 872.7 893.2 895.5 1070.8 26055.0 26135.9 26203.5 29141.6 31160.7 950.4 973.4 992.8 1019.3 1066.2 13373.7 13449.5 13480.7 13661.3 13663.9 304753.0 309835.0 311015.0 311377.0 311494.0 47439.3 47991.3 48061.0 48161.3 48304.8 1201.2 1222.2 1222.8 1235.5 1239.2 25305.4 25577.6 25699.2 25710.0 25828.4 38065.4 38505.4 38621.8 38706.0 38837.6 253782.0 254223.0 254369.0 254924.0 257024.0 29457.0 29706.4 30019.7 30118.5 30173.8 38005.6 38258.0 38453.2 38962.0 39141.8 33049.8 33618.0 33733.0 33922.0 34212.8 32913.7 33610.7 33698.3 33737.0 33748.5 37942.0 38099.4 38686.4 38771.8 38990.2 28018.9 28267.3 29212.0 30434.0 30434.2 24143.9 24333.0 25229.5 26676.3 26682.3 20:18:58 INFO - 2015-12-07 20:18:58,467 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,468 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25147.97 Median:23147.76 stddev:74059.50 (319.9%) stddev-sans-first:74243.72 20:18:58 INFO - 2015-12-07 20:18:58,468 DEBUG : BROWSER_OUTPUT: Values: 281.9 283.7 286.0 286.4 287.8 12980.6 13420.3 14921.2 15398.8 15436.7 9636.0 10137.9 10212.2 14801.4 15313.7 4478.6 4596.8 4605.8 4607.6 4610.4 4970.9 4995.8 5192.1 5200.4 5201.3 5084.7 5145.5 5160.3 5170.4 5185.8 5142.8 5357.2 5694.1 5707.5 5707.6 5059.7 5083.9 5086.0 5098.9 5120.2 11062.7 11191.3 17629.3 19590.6 19661.2 1804.5 1843.5 1847.1 1878.6 1937.0 8848.7 8853.7 8965.8 8975.6 9155.0 1678.6 1707.3 1713.5 1724.0 1756.5 54777.7 55835.2 56286.7 56316.4 57136.7 9747.4 9748.1 9790.1 9814.0 9857.3 12327.4 12343.8 12352.1 12358.8 12371.2 6909.3 6943.8 6965.9 7041.3 7206.0 6720.7 6759.6 6796.7 6900.8 6988.4 4007.3 4013.3 4122.2 4141.6 4155.1 1640.8 1641.4 1660.7 1665.9 1709.3 845.5 847.6 864.5 967.2 989.5 15662.8 15764.6 15918.1 16205.6 16434.2 833.7 845.7 848.1 852.6 855.3 8967.1 9032.8 9035.4 9233.2 9287.1 446350.0 447474.0 451050.0 460171.0 461659.0 65754.7 68196.0 68380.0 68425.7 68691.7 1032.9 1033.9 1042.0 1047.3 1055.5 14271.6 14272.9 14299.7 14301.5 15283.0 33662.5 33963.0 34672.3 34729.3 35014.1 40297.2 40449.0 42140.4 42412.6 43145.6 8828.8 8989.1 9045.6 9081.6 9115.2 11378.9 11959.6 16325.7 16460.0 16554.0 13429.9 13535.3 13859.3 13861.9 14433.1 12924.5 13169.4 13657.2 13760.7 13926.9 13300.8 13450.5 13486.1 13653.6 14030.0 8829.9 8919.9 8923.0 8977.4 9013.7 12870.3 13909.5 14142.4 14191.8 14243.7 20:18:58 INFO - 2015-12-07 20:18:58,468 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,468 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4840.56 Median:5856.78 stddev:2474.55 (42.3%) stddev-sans-first:2468.51 20:18:58 INFO - 2015-12-07 20:18:58,469 DEBUG : BROWSER_OUTPUT: Values: 1468.3 1655.8 1709.1 1731.4 1738.3 5986.3 6148.3 6998.4 7182.5 7194.9 6624.6 6804.4 6814.5 6839.2 6846.6 2022.3 2051.3 2059.7 2063.1 2063.8 2050.0 2064.2 2085.6 2093.5 2098.1 2013.2 2016.4 2027.2 2040.0 2047.6 2003.5 2019.4 2022.4 2030.2 2032.4 2022.1 2040.3 2063.1 2065.7 2074.6 6925.5 6930.7 6935.0 6955.7 6989.4 4083.4 4131.8 4149.6 4174.7 4178.0 2647.4 2687.9 2698.4 2769.8 2770.9 850.6 864.4 864.4 874.1 886.5 9342.7 9342.8 9359.8 9360.4 9373.9 3642.4 3689.3 3738.4 3761.8 3772.2 8156.2 8185.4 8188.0 8199.7 8209.1 4212.2 4215.3 4216.6 4217.2 4219.1 3207.7 3320.4 3737.0 3849.2 3859.4 3389.5 3404.1 3422.6 3424.1 3434.9 1069.8 1070.5 1079.5 1081.6 1086.0 945.4 978.3 1164.5 1190.3 1196.4 6547.3 6607.5 6611.5 6611.8 6626.2 1006.7 1049.4 1051.9 1063.4 1095.5 4986.6 5036.7 5037.7 5045.4 5046.1 7962.6 8017.6 8106.0 8220.0 8252.2 8082.4 8089.8 8096.2 8123.7 8175.8 6584.3 6671.9 6688.5 6691.3 6706.2 6294.1 6318.8 6346.4 6376.6 6390.7 7410.0 7556.0 7685.7 7710.2 7765.9 7715.9 7762.2 7806.3 7862.8 7921.6 4765.7 4842.0 5701.7 5792.4 5848.1 6541.3 6560.0 6572.6 6584.7 6597.4 5912.7 6043.9 6117.9 6381.3 6388.7 5860.5 6174.1 6181.6 6285.8 6291.8 6282.2 6308.0 6327.4 6333.4 6359.2 5721.0 5722.6 5734.6 5740.1 5751.6 5781.2 5804.3 5853.1 5863.9 5864.4 20:18:58 INFO - 2015-12-07 20:18:58,469 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4845.88 Median:5677.89 stddev:1509.06 (26.6%) stddev-sans-first:1473.57 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: Values: 262.7 264.3 266.5 266.8 272.4 5621.7 5630.5 5666.6 5710.3 5832.3 5636.6 5674.8 5681.0 5684.6 5693.2 4084.4 4187.3 4191.7 4197.7 4199.4 4169.0 4173.8 4174.9 4177.0 4185.8 4136.2 4137.8 4139.5 4152.8 4190.1 4183.6 4183.8 4189.1 4190.3 4193.8 3420.6 3461.2 3515.9 3538.8 3582.2 5345.6 5362.0 5363.4 5368.1 5385.6 4754.2 4756.9 4758.7 4766.1 4772.2 5833.1 5836.5 5849.5 5854.9 5883.5 3729.0 3801.6 3837.6 3862.7 3879.9 6168.1 6217.9 6220.0 6222.1 6235.0 3912.6 3913.4 3914.1 3916.7 3928.8 3967.2 3979.3 3981.1 3983.7 3990.4 4596.4 4619.5 4659.5 4711.0 4747.2 5902.4 5904.8 5911.8 5920.0 5925.4 1403.9 1415.8 1417.0 1417.3 1419.8 912.1 916.9 917.7 935.7 939.1 5132.1 5143.6 5158.5 5161.6 5172.5 6152.2 6168.1 6180.2 6190.7 6194.2 5137.9 5143.9 5155.2 5160.8 5171.7 3209.2 3314.8 3343.8 3344.2 3357.8 5847.4 5849.7 5854.0 5861.1 5863.9 6353.9 6400.1 6406.0 6411.5 6414.4 5667.1 5837.9 5840.3 5841.9 5843.2 6203.6 6215.0 6216.6 6227.7 6229.2 6086.1 6090.6 6093.1 6094.2 6105.0 5693.6 5803.2 5850.7 5865.8 5875.8 3965.4 4019.4 4021.2 4024.2 4031.0 5921.5 6095.9 6233.3 6234.3 6239.0 5812.7 5960.1 5999.9 6009.6 6016.6 5934.2 5965.4 5973.3 5977.3 5982.4 5692.3 5841.6 5844.2 5856.6 5860.2 6020.2 6028.1 6038.9 6039.8 6043.9 5847.2 5874.3 5881.1 5881.7 5889.7 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12022.03 Median:41878.29 stddev:13297.01 (31.8%) stddev-sans-first:13306.77 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: Values: 626.6 717.4 720.7 776.1 784.4 11470.3 11625.4 11672.8 11680.6 11692.5 11474.8 11575.5 11576.3 11605.5 11633.4 607.0 608.8 773.7 774.9 785.3 787.7 789.1 789.8 793.7 794.7 823.5 824.5 828.6 828.7 830.2 816.7 819.4 819.9 823.6 826.0 613.3 615.1 615.7 615.9 617.3 11169.6 11201.6 11224.1 11230.4 11237.9 10989.8 11557.7 11565.6 11573.2 11878.8 9488.2 9491.3 9510.3 9523.2 9553.2 3250.1 3251.5 3312.5 3313.7 3381.5 40903.8 41474.8 41681.8 41727.8 41798.8 9230.8 9402.0 9447.4 9530.8 9589.3 15524.8 15768.1 15833.8 15861.9 15869.0 6278.4 6392.6 6466.3 6500.3 6604.4 3637.0 3716.9 3731.2 3800.4 3816.6 2581.5 2592.0 2604.5 2608.8 2621.9 482.1 488.9 497.6 498.0 500.9 539.8 586.7 597.0 613.2 641.2 8126.7 8639.8 8801.3 8845.3 9041.4 493.1 501.3 559.8 582.8 590.1 3733.3 3771.2 3859.6 3863.2 3919.3 43900.0 47874.3 48620.0 48707.5 48925.5 41842.8 41913.8 42296.8 42730.8 43442.8 38459.8 38902.6 40084.8 40173.2 40218.6 7885.5 7963.2 7996.7 7997.2 8298.5 30529.4 30761.0 31011.8 31447.0 31671.0 34502.1 34900.1 34918.5 36398.6 38481.2 10043.7 10075.6 10150.5 10166.5 10363.3 10857.9 11047.4 11071.4 11078.3 11259.2 10481.5 10508.5 10530.2 10603.5 10758.8 10197.4 10253.1 10268.9 10342.2 10480.7 10413.2 10561.2 10825.4 10860.4 11022.1 9151.4 9214.5 9379.0 9494.3 9632.0 8865.0 9092.3 9118.0 9129.8 9282.4 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:18:58 INFO - 2015-12-07 20:18:58,470 DEBUG : BROWSER_OUTPUT: 20:18:59 INFO - 2015-12-07 20:18:59,213 INFO : Browser exited with error code: 0 20:18:59 INFO - 2015-12-07 20:18:59,237 INFO : Completed test dromaeo_css (00:18:34) 20:18:59 INFO - 2015-12-07 20:18:59,237 INFO : Starting test kraken 20:18:59 INFO - 2015-12-07 20:18:59,237 DEBUG : operating with platform_type : linux_ 20:18:59 INFO - 2015-12-07 20:18:59,237 INFO : Initialising browser for kraken test... 20:18:59 INFO - 2015-12-07 20:18:59,243 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR4raOC/profile http://localhost:55781/getInfo.html 20:19:03 INFO - 2015-12-07 20:19:03,990 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:19:03 INFO - 2015-12-07 20:19:03,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:19:03 INFO - 2015-12-07 20:19:03,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:19:03 INFO - 2015-12-07 20:19:03,990 DEBUG : BROWSER_OUTPUT: __metrics 20:19:04 INFO - 2015-12-07 20:19:04,087 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:05 INFO - 2015-12-07 20:19:05,025 INFO : Browser initialized. 20:19:05 INFO - 2015-12-07 20:19:05,025 INFO : Running cycle 1/1 for kraken test... 20:19:05 INFO - 2015-12-07 20:19:05,026 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpR4raOC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:19:17 INFO - 2015-12-07 20:19:17,091 DEBUG : BROWSER_OUTPUT: RSS: Main: 143331328 20:19:17 INFO - 2015-12-07 20:19:17,092 DEBUG : BROWSER_OUTPUT: 20:19:19 INFO - 2015-12-07 20:19:19,680 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:55781/tests/kraken/driver.html?testName=audio-beat-detection) 20:19:20 INFO - 2015-12-07 20:19:20,302 DEBUG : BROWSER_OUTPUT: RSS: Main: 142798848 20:19:20 INFO - 2015-12-07 20:19:20,302 DEBUG : BROWSER_OUTPUT: 20:19:23 INFO - 2015-12-07 20:19:23,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:55781/tests/kraken/driver.html?testName=audio-dft) 20:19:23 INFO - 2015-12-07 20:19:23,686 DEBUG : BROWSER_OUTPUT: RSS: Main: 142950400 20:19:23 INFO - 2015-12-07 20:19:23,686 DEBUG : BROWSER_OUTPUT: 20:19:26 INFO - 2015-12-07 20:19:26,605 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:55781/tests/kraken/driver.html?testName=audio-fft) 20:19:27 INFO - 2015-12-07 20:19:27,191 DEBUG : BROWSER_OUTPUT: RSS: Main: 138821632 20:19:27 INFO - 2015-12-07 20:19:27,191 DEBUG : BROWSER_OUTPUT: 20:19:29 INFO - 2015-12-07 20:19:29,236 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:55781/tests/kraken/driver.html?testName=audio-oscillator) 20:19:29 INFO - 2015-12-07 20:19:29,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 139751424 20:19:29 INFO - 2015-12-07 20:19:29,822 DEBUG : BROWSER_OUTPUT: 20:19:32 INFO - 2015-12-07 20:19:32,096 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:55781/tests/kraken/driver.html?testName=imaging-gaussian-blur) 20:19:32 INFO - 2015-12-07 20:19:32,690 DEBUG : BROWSER_OUTPUT: RSS: Main: 141103104 20:19:32 INFO - 2015-12-07 20:19:32,690 DEBUG : BROWSER_OUTPUT: 20:19:35 INFO - 2015-12-07 20:19:35,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:55781/tests/kraken/driver.html?testName=imaging-darkroom) 20:19:36 INFO - 2015-12-07 20:19:36,316 DEBUG : BROWSER_OUTPUT: RSS: Main: 140017664 20:19:36 INFO - 2015-12-07 20:19:36,316 DEBUG : BROWSER_OUTPUT: 20:19:39 INFO - 2015-12-07 20:19:39,850 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:55781/tests/kraken/driver.html?testName=imaging-desaturate) 20:19:40 INFO - 2015-12-07 20:19:40,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 138440704 20:19:40 INFO - 2015-12-07 20:19:40,451 DEBUG : BROWSER_OUTPUT: 20:19:43 INFO - 2015-12-07 20:19:43,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:55781/tests/kraken/driver.html?testName=json-parse-financial) 20:19:43 INFO - 2015-12-07 20:19:43,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 138002432 20:19:43 INFO - 2015-12-07 20:19:43,931 DEBUG : BROWSER_OUTPUT: 20:19:45 INFO - 2015-12-07 20:19:45,742 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:55781/tests/kraken/driver.html?testName=json-stringify-tinderbox) 20:19:46 INFO - 2015-12-07 20:19:46,345 DEBUG : BROWSER_OUTPUT: RSS: Main: 140701696 20:19:46 INFO - 2015-12-07 20:19:46,345 DEBUG : BROWSER_OUTPUT: 20:19:48 INFO - 2015-12-07 20:19:48,242 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-aes) 20:19:48 INFO - 2015-12-07 20:19:48,863 DEBUG : BROWSER_OUTPUT: RSS: Main: 141484032 20:19:48 INFO - 2015-12-07 20:19:48,863 DEBUG : BROWSER_OUTPUT: 20:19:51 INFO - 2015-12-07 20:19:51,027 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-ccm) 20:19:51 INFO - 2015-12-07 20:19:51,622 DEBUG : BROWSER_OUTPUT: RSS: Main: 140836864 20:19:51 INFO - 2015-12-07 20:19:51,622 DEBUG : BROWSER_OUTPUT: 20:19:54 INFO - 2015-12-07 20:19:54,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 20:19:54 INFO - 2015-12-07 20:19:54,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 141770752 20:19:54 INFO - 2015-12-07 20:19:54,800 DEBUG : BROWSER_OUTPUT: 20:19:57 INFO - 2015-12-07 20:19:57,485 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 20:19:58 INFO - 2015-12-07 20:19:58,078 DEBUG : BROWSER_OUTPUT: RSS: Main: 140189696 20:19:58 INFO - 2015-12-07 20:19:58,079 DEBUG : BROWSER_OUTPUT: 20:19:59 INFO - 2015-12-07 20:19:59,869 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:55781/tests/kraken/driver.html?testName=ai-astar) 20:20:00 INFO - 2015-12-07 20:20:00,120 DEBUG : BROWSER_OUTPUT: RSS: Main: 141262848 20:20:00 INFO - 2015-12-07 20:20:00,120 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,121 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:20:00 INFO - 2015-12-07 20:20:00,121 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: |0;ai-astar;116;108;114;114;114;124;114;115;117;116 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;166;130;154;170;132;152;157;139;166;138 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;164;165;163;165;165;166;163;165;164 20:20:00 INFO - 2015-12-07 20:20:00,122 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;72;74;75;73;128;79;75;73;72 20:20:00 INFO - 2015-12-07 20:20:00,123 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;94;94;138;94;95;95;130;94;95;144 20:20:00 INFO - 2015-12-07 20:20:00,123 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;111;110;110;110;111;110;110;113 20:20:00 INFO - 2015-12-07 20:20:00,123 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;147;148;147;148;148;149;147;152;147 20:20:00 INFO - 2015-12-07 20:20:00,123 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;97;97;95 20:20:00 INFO - 2015-12-07 20:20:00,124 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;77;77;77;77;79;75;76;78;76;74 20:20:00 INFO - 2015-12-07 20:20:00,124 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;76;69;69;68;69;69;69;68 20:20:00 INFO - 2015-12-07 20:20:00,124 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;84;87;86;85;85;86;86;95;84 20:20:00 INFO - 2015-12-07 20:20:00,124 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;122;131;125;119;122;128;132;129;130;126 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;136;148;166;155;153;156;148;148;152;138 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;75;71;69;70;74;71;70;74;71;71 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: __start_cc_report 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,794 20:20:00 INFO - 2015-12-07 20:20:00,125 DEBUG : BROWSER_OUTPUT: __end_cc_report 20:20:00 INFO - 2015-12-07 20:20:00,126 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548400120__endTimestamp 20:20:00 INFO - 2015-12-07 20:20:00,126 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,129 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:20:00 INFO - 2015-12-07 20:20:00,129 DEBUG : BROWSER_OUTPUT: Number of tests: 14 20:20:00 INFO - 2015-12-07 20:20:00,129 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.20 Median:115.50 stddev:3.94 (3.4%) stddev-sans-first:4.17 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: Values: 116.0 108.0 114.0 114.0 114.0 124.0 114.0 115.0 117.0 116.0 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.40 Median:155.50 stddev:14.79 (9.5%) stddev-sans-first:14.57 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: Values: 166.0 130.0 154.0 170.0 132.0 152.0 157.0 139.0 166.0 138.0 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:164.30 Median:165.00 stddev:1.06 (0.6%) stddev-sans-first:1.01 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 165.0 163.0 165.0 165.0 166.0 163.0 165.0 164.0 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,130 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:73.50 stddev:17.20 (23.4%) stddev-sans-first:18.09 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 74.0 75.0 73.0 128.0 79.0 75.0 73.0 72.0 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:107.30 Median:94.00 stddev:20.99 (22.3%) stddev-sans-first:21.71 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: Values: 94.0 94.0 138.0 94.0 95.0 95.0 130.0 94.0 95.0 144.0 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.50 Median:110.00 stddev:0.97 (0.9%) stddev-sans-first:1.01 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 111.0 110.0 110.0 110.0 111.0 110.0 110.0 113.0 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.20 Median:148.00 stddev:1.55 (1.0%) stddev-sans-first:1.62 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: Values: 149.0 147.0 148.0 147.0 148.0 148.0 149.0 147.0 152.0 147.0 20:20:00 INFO - 2015-12-07 20:20:00,131 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.00 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 97.0 97.0 95.0 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.60 Median:77.00 stddev:1.43 (1.9%) stddev-sans-first:1.51 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 77.0 77.0 79.0 75.0 76.0 78.0 76.0 74.0 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.00 stddev:2.41 (3.5%) stddev-sans-first:2.51 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 76.0 69.0 69.0 68.0 69.0 69.0 69.0 68.0 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:86.20 Median:86.00 stddev:3.26 (3.8%) stddev-sans-first:3.36 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: Values: 84.0 84.0 87.0 86.0 85.0 85.0 86.0 86.0 95.0 84.0 20:20:00 INFO - 2015-12-07 20:20:00,132 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.40 Median:128.50 stddev:4.35 (3.4%) stddev-sans-first:4.31 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: Values: 122.0 131.0 125.0 119.0 122.0 128.0 132.0 129.0 130.0 126.0 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:150.00 Median:152.50 stddev:8.71 (5.7%) stddev-sans-first:7.62 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: Values: 136.0 148.0 166.0 155.0 153.0 156.0 148.0 148.0 152.0 138.0 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.60 Median:71.00 stddev:2.01 (2.8%) stddev-sans-first:1.72 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: Values: 75.0 71.0 69.0 70.0 74.0 71.0 70.0 74.0 71.0 71.0 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:20:00 INFO - 2015-12-07 20:20:00,133 DEBUG : BROWSER_OUTPUT: 20:20:01 INFO - 2015-12-07 20:20:01,041 INFO : Browser exited with error code: 0 20:20:01 INFO - 2015-12-07 20:20:01,092 INFO : Completed test kraken (00:01:01) 20:20:01 INFO - 2015-12-07 20:20:01,092 INFO : Starting test v8_7 20:20:01 INFO - 2015-12-07 20:20:01,093 DEBUG : operating with platform_type : linux_ 20:20:01 INFO - 2015-12-07 20:20:01,093 INFO : Initialising browser for v8_7 test... 20:20:01 INFO - 2015-12-07 20:20:01,099 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2XA8tV/profile http://localhost:55781/getInfo.html 20:20:05 INFO - 2015-12-07 20:20:05,726 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 20:20:05 INFO - 2015-12-07 20:20:05,726 DEBUG : BROWSER_OUTPUT: colorDepth:24 20:20:05 INFO - 2015-12-07 20:20:05,726 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 20:20:05 INFO - 2015-12-07 20:20:05,726 DEBUG : BROWSER_OUTPUT: __metrics 20:20:05 INFO - 2015-12-07 20:20:05,868 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:06 INFO - 2015-12-07 20:20:06,801 INFO : Browser initialized. 20:20:06 INFO - 2015-12-07 20:20:06,801 INFO : Running cycle 1/1 for v8_7 test... 20:20:06 INFO - 2015-12-07 20:20:06,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2XA8tV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 20:20:18 INFO - 2015-12-07 20:20:18,741 DEBUG : BROWSER_OUTPUT: RSS: Main: 143142912 20:20:18 INFO - 2015-12-07 20:20:18,741 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,194 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:55781/tests/v8_7/run.html (next: http://localhost:55781/tests/v8_7/run.html) 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: RSS: Main: 138387456 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: __start_tp_report 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 20:20:40 INFO - 2015-12-07 20:20:40,445 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |0;Richards;167.81339150864238 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.49434242255612 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |2;Encrypt;278.08676307007784 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5208.333333333333 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1089.3246187363834 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |5;Earley;708.2152974504249 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |6;Boyer;12370.37037037037 20:20:40 INFO - 2015-12-07 20:20:40,446 DEBUG : BROWSER_OUTPUT: |7;RegExp;26342.105263157893 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: |8;Splay;613.4969325153374 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: __end_tp_report 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: __startTimestamp1449548440442__endTimestamp 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,447 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: Number of tests: 10 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:167.81 Median:167.81 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: Values: 167.8 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,448 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.49 Median:185.49 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: Values: 185.5 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:278.09 Median:278.09 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: Values: 278.1 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5208.33 Median:5208.33 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: Values: 5208.3 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,449 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1089.32 Median:1089.32 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: Values: 1089.3 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:708.22 Median:708.22 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: Values: 708.2 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12370.37 Median:12370.37 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: Values: 12370.4 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26342.11 Median:26342.11 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: Values: 26342.1 20:20:40 INFO - 2015-12-07 20:20:40,450 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:613.50 Median:613.50 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: Values: 613.5 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: Values: 4822.1 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 20:20:40 INFO - 2015-12-07 20:20:40,451 DEBUG : BROWSER_OUTPUT: 20:20:41 INFO - 2015-12-07 20:20:41,401 INFO : Browser exited with error code: 0 20:20:41 INFO - 2015-12-07 20:20:41,413 INFO : Completed test v8_7 (00:00:40) 20:20:41 INFO - 2015-12-07 20:20:41,495 INFO : Completed test suite (00:20:16) 20:20:41 INFO - 2015-12-07 20:20:41,496 DEBUG : Working with test: dromaeo_css 20:20:41 INFO - 2015-12-07 20:20:41,496 DEBUG : Generating results file: dromaeo_css 20:20:41 INFO - 2015-12-07 20:20:41,497 DEBUG : Working with test: kraken 20:20:41 INFO - 2015-12-07 20:20:41,497 DEBUG : Generating results file: kraken 20:20:41 INFO - 2015-12-07 20:20:41,497 INFO : javascript benchmark 20:20:41 INFO - 2015-12-07 20:20:41,497 DEBUG : Working with test: v8_7 20:20:41 INFO - 2015-12-07 20:20:41,497 DEBUG : Generating results file: v8_7 20:20:41 INFO - 2015-12-07 20:20:41,498 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - 2015-12-07 20:20:41,639 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 20:20:41 INFO - 2015-12-07 20:20:41,639 DEBUG : process_Request line: dromaeo_css 6293.51 graph.html#tests=[[72,132,43]] 20:20:41 INFO - 2015-12-07 20:20:41,639 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - 2015-12-07 20:20:41,684 DEBUG : process_Request line: kraken 1551.40 graph.html#tests=[[232,132,43]] 20:20:41 INFO - 2015-12-07 20:20:41,685 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 20:20:41 INFO - 2015-12-07 20:20:41,808 DEBUG : process_Request line: v8_7 21231.15 graph.html#tests=[[230,132,43]] 20:20:41 INFO - 2015-12-07 20:20:41,809 INFO : javascript benchmark 20:20:41 INFO - 2015-12-07 20:20:41,813 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2680.9195724128276, 2698.9460210795796, 2745.7117002714713, 2752.174347695691, 2764.7235276472347, 4616.884577885555, 4763.4522029966565, 4768.046390721856, 4788.569028787409, 4820.228763397857, 4641.303804429329, 4665.370175026379, 4692.6245900327895, 4800.111979283826, 4813.66304358695, 4343.609075183233, 4398.450193725785, 4514.390557274759, 4516.051629157864, 4555.74943378114, 4392.341148827685, 4448.510663826976, 4464.2187617166865, 4500.684952053358, 4597.977010114945, 4235.449391579075, 4482.731036137842, 4513.7066090704, 4539.114872599845, 4548.090381923628, 4268.210381079511, 4292.29177185764, 4329.545397733255, 4338.262495375794, 4345.565443455661, 4368.453943257093, 4385.166818304512, 4386.714863533892, 4404.955950440487, 4449.3548435477, 4563.794629241659, 4707.8587642370785, 4708.505606911259, 4725.5510726480925, 4740.5733483986605, 5013.774380152902, 5092.083424983502, 5111.923321150186, 5116.360454943132, 5145.33110695611, 5074.13739664258, 5100.69395836251, 5110.514501122388, 5118.820841270538, 5133.6149788765615, 4636.211843986531, 4643.628509719214, 4718.976405117953, 4725.267583524559, 4730.62155027597, 5266.578673706094, 5276.604254680914, 5277.683338999673, 5285.788568457296, 5305.8938821223355, 5042.067217564762, 5055.797768089235, 5058.696478211319, 5061.493850614983, 5110.48895110486, 4869.683470574401, 4987.351644286292, 5001.824936127218, 5117.257997590328, 5141.511556402136, 5020.874478138076, 5023.748812559431, 5032.144535428986, 5040.143175660147, 5089.465606111379, 5012.448630650625, 5086.796528138833, 5092.414372347153, 5095.388553373545, 5100.668456550312, 4111.444954931106, 4189.455370801777, 4230.809613567397, 4297.333913243452, 4344.9348259776125, 3761.1161377076915, 3777.036855601804, 3788.1287303920253, 3812.294725475796, 3824.541055073409, 4254.957450425518, 4409.5149533551285, 4427.933580996288, 4436.911261774811, 4442.755648439367, 4989.401271847329, 4992.126377883928, 5027.723475208825, 5030.4215015272985, 5066.417362003417, 4380.605745482858, 4389.0, 4397.956020439755, 4403.229434848889, 4427.5572442755465, 4398.362237475548, 4496.550344965477, 4566.06395688883, 4573.131105090089, 4610.677252592286, 4711.31685905535, 4738.881527961828, 4763.309320148628, 4784.617230621542, 4828.0, 5118.129917914038, 5162.148245539444, 5170.069387510284, 5173.948260517347, 5220.9216861746345, 4836.854894353034, 4846.442659094249, 4857.489963553776, 4859.854204373874, 4906.681065730716, 4815.542523460265, 4907.509249075064, 4914.65597408178, 5004.074246264453, 5047.066292735855, 5133.281340612242, 5138.3833939927445, 5140.177571588528, 5145.665531740575, 5203.401608814884, 4777.211760059551, 4976.129177394014, 5016.0, 5021.422536408214, 5022.924656130088, 4914.655974081923, 4938.506149385033, 4952.975235123801, 4975.825846095369, 5033.119204139334, 4888.902221955612, 4889.413270407432, 4923.08922849274, 4944.604431645532, 4959.950400495949, 4720.622350211906, 5037.546620804145, 5054.368203974504, 5083.313752643346, 5108.56577190943, 4785.0, 4788.377510923558, 4818.156822555969, 4839.975800120977, 4871.3667223260745], "unit": "ms", "name": "dojo.html", "value": 4677.041034115289}, {"lowerIsBetter": false, "replicates": [530.3423754544366, 531.9202119682047, 536.2090915899051, 540.0225591679061, 540.6296686769562, 35169.82415087924, 36056.45915311272, 36108.0, 36140.819295903515, 36276.0, 40492.59507404925, 41069.38395924064, 41137.17725645485, 41179.38230926531, 41221.7938910305, 8067.273945344918, 8136.0, 8204.507729536217, 8215.917840821605, 8226.218509241642, 7945.284924356807, 8045.356371490267, 8060.476069055492, 8119.797005074861, 8147.714829980951, 8033.517988920654, 8098.797530061766, 8117.0, 8135.552544610044, 8143.470674406145, 7934.563599002053, 8009.599520023976, 8045.0, 8049.557274349909, 8082.393820463489, 8011.599420029033, 8041.55771432571, 8140.0638926523025, 8162.428629995903, 8167.101618821925, 37116.628833711584, 37498.625013749785, 37576.812115939516, 37650.0, 37680.623193767984, 2768.9446211075665, 2790.260580946051, 3076.2463196516774, 3456.9827150864335, 3467.2025434150287, 27757.0, 28041.71958280432, 28225.0, 28439.0, 28569.285767855763, 3261.1357990132633, 3279.885204017848, 3282.655321191264, 3283.9014829555153, 3313.2213929726495, 215401.92299038562, 215949.0, 216606.0, 216884.0, 217960.0, 38420.35006674418, 54652.45347546553, 55389.72305138529, 55563.88797232301, 55669.0, 37001.444978325344, 37262.46006629366, 37341.62658373436, 37342.62657373446, 37521.81239093787, 13254.602361929157, 13341.266230357229, 13541.796873046913, 13578.0, 13596.524121655695, 10448.895511044791, 10483.161347092215, 10531.631392901212, 10554.47227638615, 10586.894131058745, 12936.47738690965, 13127.343632818322, 13549.729005419837, 13557.864421355858, 13567.457301708018, 5391.73041347931, 5421.2952316199435, 5452.863678408072, 5517.2551705519245, 5532.806351777668, 780.7306479264645, 872.6727477196051, 893.2228960804142, 895.5343221524771, 1070.817960946641, 26055.0, 26135.869320653655, 26203.475930481283, 29141.56287655687, 31160.688393116234, 950.4059962523423, 973.4062222044547, 992.7815880506278, 1019.2814066083394, 1066.1524088349781, 13373.732525349438, 13449.529266475627, 13480.730385392433, 13661.316934153252, 13663.863361366259, 304753.0, 309835.0, 311015.0, 311377.0, 311494.0, 47439.28841067387, 47991.28013079806, 48061.0, 48161.277580836315, 48304.7584762074, 1201.2252097397304, 1222.2238878312335, 1222.7711150293899, 1235.5366737473628, 1239.2254840724547, 25305.367365815266, 25577.616335754607, 25699.229023129337, 25710.0, 25828.35429114287, 38065.4290185653, 38505.42241866318, 38621.80689096537, 38706.0323491915, 38837.6116238834, 253782.0, 254223.0, 254369.0, 254924.0, 257024.0, 29456.995875604636, 29706.405871882875, 30019.69980300169, 30118.548221777128, 30173.849130754206, 38005.61994380021, 38258.0, 38453.230935381696, 38962.0, 39141.80429097836, 33049.83475082609, 33618.0, 33733.0, 33922.0, 34212.82893585516, 32913.67086329106, 33610.663893360754, 33698.326033478705, 33737.0, 33748.49377259294, 37942.0, 38099.42850857295, 38686.419703703905, 38771.806140969114, 38990.220195595364, 28018.85990570034, 28267.293317667223, 29212.0, 30434.0, 30434.239144021576, 24143.879280603483, 24333.0, 25229.495410092062, 26676.333091672088, 26682.332941676614], "unit": "ms", "name": "ext.html", "value": 16547.145912341042}, {"lowerIsBetter": false, "replicates": [281.8590704647676, 283.71911807310755, 285.96480739722205, 286.38570266777765, 287.83449516527986, 12980.61058168254, 13420.261885596288, 14921.179335136563, 15398.769018464718, 15436.691266174685, 9635.951820240907, 10137.898621013788, 10212.183025357972, 14801.407943682267, 15313.693726125472, 4478.552144785528, 4596.839110631128, 4605.838795642137, 4607.562281583244, 4610.423697037871, 4970.900581988358, 4995.825146119886, 5192.1432963560965, 5200.375954885419, 5201.271821944931, 5084.694918304914, 5145.485451454843, 5160.2517634942915, 5170.353705786777, 5185.844424667266, 5142.794288228466, 5357.249985002103, 5694.145878118274, 5707.457791509779, 5707.600467967244, 5059.721715305656, 5083.872903177413, 5085.974570127163, 5098.898022039575, 5120.15517439622, 11062.668119956414, 11191.32852028881, 17629.294828206857, 19590.608187836162, 19661.213551457924, 1804.5218017225445, 1843.4746097362188, 1847.058000419782, 1878.5585387433941, 1937.0314842578712, 8848.734537963872, 8853.690120845804, 8965.820683586357, 8975.551222438851, 9155.0, 1678.613918798671, 1707.2744083764474, 1713.5459103337625, 1723.9913800430918, 1756.464278395089, 54777.726111369586, 55835.162472562944, 56286.71856640732, 56316.43683563153, 57136.71431642815, 9747.3664211826, 9748.073932976356, 9790.118889299854, 9814.0, 9857.260705447121, 12327.445264963098, 12343.753124937452, 12352.07359448045, 12358.814617780741, 12371.195872268454, 6909.343612356818, 6943.79168624942, 6965.930340696528, 7041.260667629927, 7206.0, 6720.697568609425, 6759.628220447923, 6796.669631880442, 6900.827479312957, 6988.440924726111, 4007.3332900395812, 4013.3177359848896, 4122.175564887035, 4141.565135660772, 4155.148194620096, 1640.7949006374204, 1641.433705371645, 1660.7342825147919, 1665.8667306615441, 1709.2564734340601, 845.5476320168681, 847.6058632735808, 864.4985908173245, 967.2358836519071, 989.4953573677476, 15662.765058524132, 15764.60588485297, 15918.106971273732, 16205.594860128354, 16434.178291085398, 833.7207035643128, 845.7124577643508, 848.1052489623506, 852.6205838401852, 855.2901092093548, 8967.103289671111, 9032.819343613091, 9035.412698174598, 9233.169014788702, 9287.117723816227, 446350.0, 447474.0, 451050.0, 460171.0, 461659.0, 65754.67122664356, 68196.0, 68380.0, 68425.65787171132, 68691.65654171698, 1032.8863824979246, 1033.9017793309624, 1042.0, 1047.3192424923861, 1055.5408397347178, 14271.643208919444, 14272.928635357172, 14299.71400571962, 14301.499447519287, 15283.0, 33662.495062573595, 33963.0, 34672.30655386928, 34729.305413891074, 35014.12464688403, 40297.21721141418, 40449.0, 42140.367894482224, 42412.575874240865, 43145.568544314156, 8828.779280518038, 8989.146031127033, 9045.592948317473, 9081.636734530544, 9115.22520585731, 11378.943105284421, 11959.581414650445, 16325.67348653044, 16460.0, 16554.0, 13429.865701343253, 13535.323233838466, 13859.30703464843, 13861.930690346484, 14433.134011959317, 12924.483020679067, 13169.407376668265, 13657.248851313274, 13760.724785504033, 13926.860731392557, 13300.800487992881, 13450.46198152063, 13486.12340197884, 13653.590392288248, 14030.0, 8829.867551986597, 8919.866202006846, 8923.0, 8977.416467929565, 9013.729588112104, 12870.292133932724, 13909.513167039106, 14142.363593638516, 14191.787123193368, 14243.715125697636], "unit": "ms", "name": "jquery.html", "value": 8103.853020331966}, {"lowerIsBetter": false, "replicates": [1468.2878803780159, 1655.7847479827624, 1709.077098366882, 1731.4026660802026, 1738.3307426640743, 5986.341502434729, 6148.262208534971, 6998.440124790018, 7182.533135346199, 7194.892076618855, 6624.635645039521, 6804.421624161952, 6814.4548436125115, 6839.2134904486, 6846.623435711034, 2022.2719820864513, 2051.2615458434952, 2059.742532183477, 2063.0613071052635, 2063.772984971652, 2050.0467282713535, 2064.1743302678974, 2085.5828834233216, 2093.5289559849066, 2098.1187901081507, 2013.224908410258, 2016.3648450738044, 2027.2397850805949, 2040.010594861491, 2047.5802460495638, 2003.5191554027074, 2019.4345583236643, 2022.4337185588058, 2030.1980717616607, 2032.4410787033537, 2022.1102714805586, 2040.2553068130173, 2063.0613071052635, 2065.710800487933, 2074.5747121839986, 6925.480588955798, 6930.653467326613, 6935.029095926574, 6955.6869940852785, 6989.4408447324095, 4083.448734420845, 4131.814068366931, 4149.6265336119895, 4174.70777045607, 4177.97911010443, 2647.35139890728, 2687.87904544296, 2698.406350602864, 2769.8476583788083, 2770.8753106110275, 850.5832142250315, 864.4035615425399, 864.4381152251025, 874.1215078845783, 886.5345693510894, 9342.71971840839, 9342.766430839216, 9359.812803743887, 9360.391574547633, 9373.859392109192, 3642.3625865473437, 3689.2990331836863, 3738.36447803874, 3761.755485893408, 3772.2266935278203, 8156.225158609923, 8185.427020108655, 8188.0, 8199.71301004462, 8209.055958564722, 4212.220739163265, 4215.304474761691, 4216.599423054805, 4217.198732240864, 4219.135077309144, 3207.7273431758563, 3320.4189266878197, 3737.0470530014672, 3849.2493963677375, 3859.4017927221325, 3389.49157626358, 3404.0808981575333, 3422.6064002640014, 3424.143964008998, 3434.8797792077658, 1069.7806949575318, 1070.4852633523633, 1079.4710591810115, 1081.6106201767357, 1085.9565617375374, 945.4469135555639, 978.2565250409598, 1164.5050853387277, 1190.3453100794702, 1196.4017991004498, 6547.279799222082, 6607.471402287805, 6611.471082313404, 6611.834704132339, 6626.171728533934, 1006.7080546641538, 1049.3651340938775, 1051.8790339111101, 1063.4151216830867, 1095.5179720922768, 4986.601071914238, 5036.748162591855, 5037.672551284155, 5045.369328833895, 5046.091703493333, 7962.56205908669, 8017.559034253172, 8105.959470202612, 8220.0, 8252.174782521699, 8082.353411727047, 8089.797755056053, 8096.230858068592, 8123.7156699515235, 8175.836483270301, 6584.2599536151965, 6671.933280667131, 6688.4649228061635, 6691.26396096429, 6706.228783689938, 6294.055891616111, 6318.810435686937, 6346.428821406095, 6376.553641245254, 6390.680465976589, 7410.036695229585, 7555.962220188864, 7685.654145563351, 7710.190430004993, 7765.922340776746, 7715.884261735966, 7762.184970578234, 7806.258405451473, 7862.803429914298, 7921.603919804102, 4765.714057156443, 4841.975790121027, 5701.686407247641, 5792.4497172768515, 5848.064309710596, 6541.34586541342, 6559.967200163968, 6572.572782769104, 6584.670766461753, 6597.373249541286, 5912.733926973383, 6043.879122417615, 6117.877642447215, 6381.329960354096, 6388.68056597159, 5860.472557469848, 6174.135621013152, 6181.567290289637, 6285.842853928689, 6291.811245662638, 6282.246130464374, 6307.96846015767, 6327.430531252209, 6333.398327158912, 6359.17330747, 5721.027425337619, 5722.599418040697, 5734.569907257056, 5740.13897915316, 5751.626144300607, 5781.161731548817, 5804.303483581997, 5853.09277062056, 5863.912041319299, 5864.413558644102], "unit": "ms", "name": "mootools.html", "value": 4012.9079419994246}, {"lowerIsBetter": false, "replicates": [262.7083936830118, 264.3088324032655, 266.54287896257915, 266.84122946846617, 272.3708233979507, 5621.662700237988, 5630.465105814947, 5666.631668941516, 5710.314762228533, 5832.300123985127, 5636.605437619368, 5674.773009079642, 5681.005823980808, 5684.573656975723, 5693.202951586781, 4084.407760874664, 4187.267228235062, 4191.748495090289, 4197.685173611976, 4199.3910882921955, 4168.958310416902, 4173.812178451977, 4174.874753757392, 4176.99752059505, 4185.811638476261, 4136.21411931732, 4137.813798379065, 4139.461869956901, 4152.8131234094535, 4190.057237121654, 4183.644390226835, 4183.832646694129, 4189.141226048653, 4190.308599081148, 4193.769342686151, 3420.555327807394, 3461.16931936336, 3515.8593656253975, 3538.840752166133, 3582.194006348551, 5345.625806193568, 5362.0, 5363.383210930754, 5368.087425137697, 5385.623006389555, 4754.239321708545, 4756.881077973044, 4758.738269395182, 4766.142094423002, 4772.164871147535, 5833.06670932653, 5836.503897168745, 5849.502792262663, 5854.912176317359, 5883.470487656089, 3728.9627103728885, 3801.600831912637, 3837.57786643469, 3862.6909847212437, 3879.8836034919, 6168.074788781674, 6217.875642487125, 6219.968900155515, 6222.066689996492, 6234.9688251558455, 3912.56961734209, 3913.3934240192816, 3914.0606254498716, 3916.7258291919293, 3928.8232029558167, 3967.2263908538134, 3979.303621866162, 3981.124152686404, 3983.7410568312966, 3990.4413382126527, 4596.4024676791805, 4619.46876109245, 4659.464161621389, 4710.9764451177525, 4747.169245382044, 5902.439268269508, 5904.7933322334375, 5911.793087241926, 5920.023196172583, 5925.377835327315, 1403.9087459315112, 1415.801787749716, 1416.9504067357593, 1417.3267697843648, 1419.7657386531107, 912.119804388768, 916.867054277126, 917.7338571814232, 935.695898832882, 939.0656296984544, 5132.10188217068, 5143.588512918957, 5158.484151584811, 5161.638685291993, 5172.456892026283, 6152.230971128609, 6168.136460895478, 6180.196574445294, 6190.690465476799, 6194.194754681863, 5137.8715532112, 5143.871403214949, 5155.175171972466, 5160.819371321985, 5171.741412929414, 3209.1816586770224, 3314.751393645486, 3343.7993720376367, 3344.247544302561, 3357.8321083945707, 5847.415258474119, 5849.6782676952325, 5853.970730146322, 5861.0915308127305, 5863.853403664943, 6353.904691429632, 6400.135981642512, 6406.0390941359165, 6411.455026322721, 6414.390632889868, 5667.1499275108235, 5837.854053648693, 5840.2991641003355, 5841.912371314434, 5843.152742852348, 6203.565750397429, 6215.036669316263, 6216.595921265103, 6227.688615569113, 6229.190205273286, 6086.056661217518, 6090.634561926121, 6093.116498107838, 6094.238220222473, 6105.0, 5693.601447898607, 5803.158542011469, 5850.7074646266665, 5865.765369385347, 5875.823725288248, 3965.385365268388, 4019.4171845082883, 4021.155557332993, 4024.1951609678767, 4030.979845100756, 5921.496672782861, 6095.878082438415, 6233.283172435046, 6234.3453937337745, 6239.032949892774, 5812.73842677089, 5960.105984102246, 5999.850003749767, 6009.609375390585, 6016.639001659914, 5934.228550288608, 5965.373635768182, 5973.313068997121, 5977.252843394575, 5982.431668991613, 5692.260006199168, 5841.591088623755, 5844.1525978732, 5856.648601083949, 5860.15027820955, 6020.217371741645, 6028.065649824284, 6038.939610604013, 6039.818805435844, 6043.939560604514, 5847.181394604844, 5874.295084589877, 5881.147233651182, 5881.73532191061, 5889.676067816311], "unit": "ms", "name": "prototype.html", "value": 4336.290126445083}, {"lowerIsBetter": false, "replicates": [626.6240255846495, 717.4439809147912, 720.700909122714, 776.1384862802289, 784.3529088501983, 11470.25443346182, 11625.360605166712, 11672.824907626382, 11680.591179308725, 11692.532298708064, 11474.827877581843, 11575.479103440344, 11576.305421674706, 11605.47775350109, 11633.36016519091, 607.0348146447149, 608.8082254089969, 773.7446642607925, 774.8760198368262, 785.2971590426565, 787.7321710618388, 789.0649580247397, 789.763071078677, 793.7301317552032, 794.6543253684637, 823.4853216739538, 824.4805772363403, 828.5732847583499, 828.747232094211, 830.244477525452, 816.7304789419477, 819.418213068719, 819.942604017719, 823.5840900345318, 825.9793505162359, 613.3437222172278, 615.1142355008818, 615.6552330694825, 615.8583525789094, 617.2870334763355, 11169.553217871357, 11201.551937922473, 11224.102071834233, 11230.382328971904, 11237.943810280896, 10989.780204395947, 11557.653270401901, 11565.595204167814, 11573.189876708633, 11878.762424751543, 9488.193503552206, 9491.322859348114, 9510.28672849532, 9523.19052880506, 9553.187979021792, 3250.073728987251, 3251.5122731590213, 3312.453445181566, 3313.7349012078976, 3381.509681096252, 40903.7954810227, 41474.79262603698, 41681.79159104215, 41727.791361043, 41798.79100604508, 9230.815383692288, 9402.0, 9447.385919915183, 9530.809383812284, 9589.280803939733, 15524.844751552566, 15768.132752698712, 15833.841661583467, 15861.920690396704, 15869.0, 6278.4035516625845, 6392.648404337806, 6466.321036291216, 6500.349965003462, 6604.3725846044545, 3637.0, 3716.9070773230346, 3731.2350968051483, 3800.3539398302355, 3816.599257078022, 2581.4707984863435, 2592.0, 2604.4660844526825, 2608.817382783187, 2621.895124195011, 482.1081000149695, 488.90955173293054, 497.58948867184716, 498.04375598850294, 500.9499050095034, 539.8245570189704, 586.718375179916, 597.0387675841891, 613.2028363127915, 641.1696852575925, 8126.715564955198, 8639.827203456021, 8801.25189358899, 8845.336599755045, 9041.367104302768, 493.1443944755846, 501.2581379558274, 559.7509108446784, 582.7639805878626, 590.1266126133261, 3733.3466643337306, 3771.2080463102507, 3859.614038596118, 3863.2273545291055, 3919.3141200290406, 43900.0, 47874.28188577174, 48620.0, 48707.512924870294, 48925.51074489281, 41842.79078604587, 41913.79043104765, 42296.788516057226, 42730.78634606807, 43442.78278608587, 38459.80770096132, 38902.61097389046, 40084.799576002515, 40173.1965360697, 40218.59781402207, 7885.526868387915, 7963.243491868263, 7996.720114796187, 7997.2083052917105, 8298.502089874386, 30529.38941221119, 30761.0, 31011.84494077515, 31447.0, 31671.0, 34502.137446563036, 34900.127496812784, 34918.476222857185, 36398.636013640586, 38481.23037539177, 10043.69868903934, 10075.596976120873, 10150.492475376053, 10166.542505587415, 10363.326383785332, 10857.891421085687, 11047.392393418439, 11071.391073491035, 11078.335299882034, 11259.211855170059, 10481.475926203508, 10508.474576271308, 10530.21023423231, 10603.522841472306, 10758.762742284738, 10197.388156710622, 10253.128484078938, 10268.948655256676, 10342.224333174892, 10480.737981550523, 10413.166946644402, 10561.155107591529, 10825.350478971286, 10860.402677852793, 11022.118230541697, 9151.405158664666, 9214.539273036455, 9379.0, 9494.287928405536, 9632.006676336958, 8864.955675221583, 9092.272618190662, 9118.0, 9129.77175570616, 9282.443053416817], "unit": "ms", "name": "yui.html", "value": 5693.132272576954}], "name": "dromaeo_css", "value": 6293.510912641914}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 108.0, 114.0, 114.0, 114.0, 124.0, 114.0, 115.0, 117.0, 116.0], "unit": "ms", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [166.0, 130.0, 154.0, 170.0, 132.0, 152.0, 157.0, 139.0, 166.0, 138.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.4}, {"lowerIsBetter": true, "replicates": [163.0, 164.0, 165.0, 163.0, 165.0, 165.0, 166.0, 163.0, 165.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 164.3}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 75.0, 73.0, 128.0, 79.0, 75.0, 73.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 138.0, 94.0, 95.0, 95.0, 130.0, 94.0, 95.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 107.3}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 111.0, 110.0, 110.0, 110.0, 111.0, 110.0, 110.0, 113.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.5}, {"lowerIsBetter": true, "replicates": [149.0, 147.0, 148.0, 147.0, 148.0, 148.0, 149.0, 147.0, 152.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 97.0, 97.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.0}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 77.0, 77.0, 79.0, 75.0, 76.0, 78.0, 76.0, 74.0], "unit": "ms", "name": "json-parse-financial", "value": 76.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 76.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.3}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 87.0, 86.0, 85.0, 85.0, 86.0, 86.0, 95.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 86.2}, {"lowerIsBetter": true, "replicates": [122.0, 131.0, 125.0, 119.0, 122.0, 128.0, 132.0, 129.0, 130.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.4}, {"lowerIsBetter": true, "replicates": [136.0, 148.0, 166.0, 155.0, 153.0, 156.0, 148.0, 148.0, 152.0, 138.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 150.0}, {"lowerIsBetter": true, "replicates": [75.0, 71.0, 69.0, 70.0, 74.0, 71.0, 70.0, 74.0, 71.0, 71.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 71.6}], "name": "kraken", "value": 1551.3999999999999}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [167.81339150864238], "unit": "score", "name": "Richards", "value": 210.36461799999995}, {"lowerIsBetter": false, "replicates": [185.49434242255612], "unit": "score", "name": "DeltaBlue", "value": 356.44213800000017}, {"lowerIsBetter": false, "replicates": [278.08676307007784], "unit": "score", "name": "Encrypt", "value": 957.1868759999999}, {"lowerIsBetter": false, "replicates": [5208.333333333333], "unit": "score", "name": "Decrypt", "value": 51.10675199999996}, {"lowerIsBetter": false, "replicates": [1089.3246187363834], "unit": "score", "name": "RayTrace", "value": 679.3099019999999}, {"lowerIsBetter": false, "replicates": [708.2152974504249], "unit": "score", "name": "Earley", "value": 941.0457559999996}, {"lowerIsBetter": false, "replicates": [12370.37037037037], "unit": "score", "name": "Boyer", "value": 53.87575149700595}, {"lowerIsBetter": false, "replicates": [26342.105263157893], "unit": "score", "name": "RegExp", "value": 34.58284715284714}, {"lowerIsBetter": false, "replicates": [613.4969325153374], "unit": "score", "name": "Splay", "value": 132.83032999999998}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 21231.146513355598}]} 20:20:41 INFO - RETURN: dromaeo_css: 6293.51 20:20:41 INFO - RETURN: kraken: 1551.40 20:20:41 INFO - RETURN: v8_7: 21231.15 20:20:41 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21231.15"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1551.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6293.51"}}} 20:20:41 INFO - Return code: 0 20:20:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 20:20:41 INFO - # TBPL SUCCESS # 20:20:41 INFO - Running post-action listener: _resource_record_post_action 20:20:41 INFO - Running post-run listener: _resource_record_post_run 20:20:43 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 528003072; Read time: 180; Write time: 706800 20:20:43 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 0; Write bytes: 251056128; Read time: 0; Write time: 533168 20:20:43 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 8192; Write bytes: 276082688; Read time: 180; Write time: 173592 20:20:43 INFO - Running post-run listener: _upload_blobber_files 20:20:43 INFO - Blob upload gear active. 20:20:43 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 20:20:43 INFO - Copying logs to upload dir... 20:20:43 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1267.342356 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 7 secs) (at 2015-12-07 20:20:42.218849) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:42.222755) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 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.008639 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:42.272753) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:42.273066) ========= 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=820bb6602ddf640013a48df2000001a9-1449536814.228590-975696308 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004642 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-07 20:20:42.324822) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:20:42.325544) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-07 20:20:42.326173) ========= ========= Total master_lag: 0.22 =========