builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1449688787.45 results: success (0) buildid: 20151209104438 builduid: e252137886f546ac95ef0e37e35dde6b revision: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.452441) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.452870) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.453155) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006479 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.476741) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.477016) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.498447) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.498845) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004641 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.548470) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.548771) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.549104) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.549386) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-12-09 11:19:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 47.7M=0s 2015-12-09 11:19:47 (47.7 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.187118 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.749931) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.750250) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.019724 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:47.800314) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:19:47.800673) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 --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 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 --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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-12-09 11:19:47,912 truncating revision to first 12 chars 2015-12-09 11:19:47,912 Setting DEBUG logging. 2015-12-09 11:19:47,912 attempt 1/10 2015-12-09 11:19:47,912 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/575efef2e8cd?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-12-09 11:19:48,629 unpacking tar archive at: fx-team-575efef2e8cd/testing/mozharness/ program finished with exit code 0 elapsedTime=1.014864 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-12-09 11:19:48.828642) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:48.828999) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:48.837764) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:48.838203) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-12-09 11:19:48.838670) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-09 11:19:48.838984) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 11:19:49 INFO - MultiFileLogger online at 20151209 11:19:49 in /builds/slave/test 11:19:49 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 11:19:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 11:19:49 INFO - {'append_to_log': False, 11:19:49 INFO - 'base_work_dir': '/builds/slave/test', 11:19:49 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 11:19:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 11:19:49 INFO - 'branch': 'Fx-Team-Non-PGO', 11:19:49 INFO - 'buildbot_json_path': 'buildprops.json', 11:19:49 INFO - 'config_files': ('talos/linux_config.py',), 11:19:49 INFO - 'default_actions': ('clobber', 11:19:49 INFO - 'read-buildbot-config', 11:19:49 INFO - 'download-and-extract', 11:19:49 INFO - 'populate-webroot', 11:19:49 INFO - 'create-virtualenv', 11:19:49 INFO - 'install', 11:19:49 INFO - 'run-tests'), 11:19:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 11:19:49 INFO - 'download_minidump_stackwalk': True, 11:19:49 INFO - 'download_symbols': 'ondemand', 11:19:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 11:19:49 INFO - 'tooltool.py': '/tools/tooltool.py', 11:19:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 11:19:49 INFO - '/tools/misc-python/virtualenv.py')}, 11:19:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 11:19:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 11:19:49 INFO - 'installer_path': 'installer.exe', 11:19:49 INFO - 'log_level': 'info', 11:19:49 INFO - 'log_name': 'talos', 11:19:49 INFO - 'log_to_console': True, 11:19:49 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 11:19:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 11:19:49 INFO - 'opt_config_files': (), 11:19:49 INFO - 'pip_index': False, 11:19:49 INFO - 'sps_profile': False, 11:19:49 INFO - 'sps_profile_interval': 0, 11:19:49 INFO - 'suite': 'dromaeojs', 11:19:49 INFO - 'system_bits': '64', 11:19:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 11:19:49 INFO - 'title': 'talos-linux64-ix-055', 11:19:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 11:19:49 INFO - 'use_talos_json': True, 11:19:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 11:19:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 11:19:49 INFO - 'work_dir': 'build'} 11:19:49 INFO - ##### 11:19:49 INFO - ##### Running clobber step. 11:19:49 INFO - ##### 11:19:49 INFO - Running pre-action listener: _resource_record_pre_action 11:19:49 INFO - Running main action method: clobber 11:19:49 INFO - rmtree: /builds/slave/test/build 11:19:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 11:19:49 INFO - Running post-action listener: _resource_record_post_action 11:19:49 INFO - ##### 11:19:49 INFO - ##### Running read-buildbot-config step. 11:19:49 INFO - ##### 11:19:49 INFO - Running pre-action listener: _resource_record_pre_action 11:19:49 INFO - Running main action method: read_buildbot_config 11:19:49 INFO - Using buildbot properties: 11:19:49 INFO - { 11:19:49 INFO - "properties": { 11:19:49 INFO - "buildnumber": 1000, 11:19:49 INFO - "product": "firefox", 11:19:49 INFO - "script_repo_revision": "production", 11:19:49 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 11:19:49 INFO - "repository": "", 11:19:49 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 11:19:49 INFO - "buildid": "20151209104438", 11:19:49 INFO - "slavename": "talos-linux64-ix-055", 11:19:49 INFO - "pgo_build": "False", 11:19:49 INFO - "basedir": "/builds/slave/test", 11:19:49 INFO - "project": "", 11:19:49 INFO - "platform": "ubuntu64_hw", 11:19:49 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 11:19:49 INFO - "slavebuilddir": "test", 11:19:49 INFO - "scheduler": "tests-fx-team-linux64-talos", 11:19:49 INFO - "branch": "fx-team", 11:19:49 INFO - "repo_path": "integration/fx-team", 11:19:49 INFO - "stage_platform": "linux64", 11:19:49 INFO - "builduid": "e252137886f546ac95ef0e37e35dde6b", 11:19:49 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:49 INFO - }, 11:19:49 INFO - "sourcestamp": { 11:19:49 INFO - "repository": "", 11:19:49 INFO - "hasPatch": false, 11:19:49 INFO - "project": "", 11:19:49 INFO - "branch": "fx-team-linux64-talos", 11:19:49 INFO - "changes": [ 11:19:49 INFO - { 11:19:49 INFO - "category": null, 11:19:49 INFO - "files": [ 11:19:49 INFO - { 11:19:49 INFO - "url": null, 11:19:49 INFO - "name": "https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 11:19:49 INFO - } 11:19:49 INFO - ], 11:19:49 INFO - "repository": "", 11:19:49 INFO - "rev": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8", 11:19:49 INFO - "who": "mleibovic@mozilla.com", 11:19:49 INFO - "when": 1449688750, 11:19:49 INFO - "number": 7172124, 11:19:49 INFO - "comments": "Bug 1221513 - Disable test_TelemetryEnvironment.js on Android. r=me", 11:19:49 INFO - "project": "", 11:19:49 INFO - "at": "Wed 09 Dec 2015 11:19:10", 11:19:49 INFO - "branch": "fx-team-linux64-talos", 11:19:49 INFO - "revlink": "", 11:19:49 INFO - "properties": [ 11:19:49 INFO - [ 11:19:49 INFO - "buildid", 11:19:49 INFO - "20151209104438", 11:19:49 INFO - "Change" 11:19:49 INFO - ], 11:19:49 INFO - [ 11:19:49 INFO - "builduid", 11:19:49 INFO - "e252137886f546ac95ef0e37e35dde6b", 11:19:49 INFO - "Change" 11:19:49 INFO - ], 11:19:49 INFO - [ 11:19:49 INFO - "pgo_build", 11:19:49 INFO - "False", 11:19:49 INFO - "Change" 11:19:49 INFO - ] 11:19:49 INFO - ], 11:19:49 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:49 INFO - } 11:19:49 INFO - ], 11:19:49 INFO - "revision": "575efef2e8cdd0cba6ad58958a44db2f5f2c72c8" 11:19:49 INFO - } 11:19:49 INFO - } 11:19:49 INFO - Found installer url https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 11:19:49 INFO - Running post-action listener: _resource_record_post_action 11:19:49 INFO - ##### 11:19:49 INFO - ##### Running download-and-extract step. 11:19:49 INFO - ##### 11:19:49 INFO - Running pre-action listener: _resource_record_pre_action 11:19:49 INFO - Running main action method: download_and_extract 11:19:49 INFO - mkdir: /builds/slave/test/build/tests 11:19:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:19:49 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 11:19:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json 11:19:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json 11:19:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 11:19:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 11:19:52 INFO - Downloaded 1302 bytes. 11:19:52 INFO - Reading from file /builds/slave/test/build/test_packages.json 11:19:52 INFO - Using the following test package requirements: 11:19:52 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:52 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 11:19:52 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'jsshell-linux-x86_64.zip'], 11:19:52 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 11:19:52 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:52 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 11:19:52 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 11:19:52 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 11:19:52 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 11:19:52 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 11:19:52 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 11:19:52 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 11:19: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')]} 11:19:52 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:19:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:55 INFO - Downloaded 21860154 bytes. 11:19:55 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 11:19:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:55 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 11:19:56 INFO - Return code: 0 11:19:56 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 11:19:56 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')]} 11:19:56 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 11:19:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:57 INFO - Downloaded 21860154 bytes. 11:19:57 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 11:19:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 11:19:57 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 11:19:58 INFO - Return code: 0 11:19: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')]} 11:19:58 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 11:19:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:59 INFO - Downloaded 11132038 bytes. 11:19:59 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 11:19:59 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 11:19:59 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 11:19:59 INFO - Return code: 0 11:19:59 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')]} 11:19:59 INFO - https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 11:19:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:19:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:19:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:19:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:20:00 INFO - Downloaded 57733956 bytes. 11:20:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:00 INFO - mkdir: /builds/slave/test/properties 11:20:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 11:20:00 INFO - Writing to file /builds/slave/test/properties/build_url 11:20:00 INFO - Contents: 11:20:00 INFO - build_url:https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 11:20:00 INFO - Running post-action listener: _resource_record_post_action 11:20:00 INFO - Running post-action listener: set_extra_try_arguments 11:20:00 INFO - ##### 11:20:00 INFO - ##### Running populate-webroot step. 11:20:00 INFO - ##### 11:20:00 INFO - Running pre-action listener: _resource_record_pre_action 11:20:00 INFO - Running main action method: populate_webroot 11:20:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 11:20:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 11:20:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 11:20:00 INFO - '--tppagecycles', 11:20:00 INFO - '7'], 11:20:00 INFO - 'tests': ['tsvgm']}}, 11:20:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 11:20:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 11:20:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 11:20:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 11:20:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'tests': ['damp', 'tps']}, 11:20:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['damp', 'tps']}, 11:20:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 11:20:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 11:20:00 INFO - 'other': {'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'other_l64': {'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'other_nol64': {'tests': ['a11yr', 11:20:00 INFO - 'ts_paint', 11:20:00 INFO - 'tpaint', 11:20:00 INFO - 'sessionrestore', 11:20:00 INFO - 'sessionrestore_no_auto_restore']}, 11:20:00 INFO - 'svgr': {'tests': ['tsvgx', 11:20:00 INFO - 'tsvgr_opacity', 11:20:00 INFO - 'tart', 11:20:00 INFO - 'tscrollx', 11:20:00 INFO - 'cart']}, 11:20:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['tsvgx', 11:20:00 INFO - 'tsvgr_opacity', 11:20:00 INFO - 'tart', 11:20:00 INFO - 'tscrollx', 11:20:00 INFO - 'cart']}, 11:20:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'tests': ['tp5o']}, 11:20:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'talos_options': ['--e10s'], 11:20:00 INFO - 'tests': ['tp5o']}, 11:20:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'talos_options': ['--xperf_path', 11:20:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:00 INFO - 'tests': ['tp5n']}, 11:20:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 11:20:00 INFO - 'talos_options': ['--e10s', 11:20:00 INFO - '--xperf_path', 11:20:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 11:20:00 INFO - 'tests': ['tp5n']}}, 11:20:00 INFO - 'talos.zip': {'path': '', 11:20:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 11:20:00 INFO - Running post-action listener: _resource_record_post_action 11:20:00 INFO - ##### 11:20:00 INFO - ##### Running create-virtualenv step. 11:20:00 INFO - ##### 11:20:00 INFO - Running pre-action listener: _resource_record_pre_action 11:20:00 INFO - Running main action method: create_virtualenv 11:20:00 INFO - Creating virtualenv /builds/slave/test/build/venv 11:20:00 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 11:20:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 11:20:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 11:20:01 INFO - Using real prefix '/usr' 11:20:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 11:20:01 INFO - Installing distribute.............................................................................................................................................................................................done. 11:20:03 INFO - Installing pip.................done. 11:20:03 INFO - Return code: 0 11:20:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 11:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:03 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:03 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 11:20:03 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 11:20:03 INFO - Using env: {'DISPLAY': ':0', 11:20:03 INFO - 'HOME': '/home/cltbld', 11:20:03 INFO - 'LANG': 'en_US.UTF-8', 11:20:03 INFO - 'LANGUAGE': 'en_US:en', 11:20:03 INFO - 'LOGNAME': 'cltbld', 11:20:03 INFO - 'MAIL': '/var/mail/cltbld', 11:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:03 INFO - 'MOZ_NO_REMOTE': '1', 11:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:03 INFO - 'NO_EM_RESTART': '1', 11:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:03 INFO - 'PWD': '/builds/slave/test', 11:20:03 INFO - 'SHELL': '/bin/bash', 11:20:03 INFO - 'SHLVL': '1', 11:20:03 INFO - 'TERM': 'linux', 11:20:03 INFO - 'TMOUT': '86400', 11:20:03 INFO - 'USER': 'cltbld', 11:20:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:03 INFO - '_': '/tools/buildbot/bin/python'} 11:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:03 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 11:20:03 INFO - Cleaning up... 11:20:03 INFO - Return code: 0 11:20:03 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 11:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:03 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:03 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 11:20:03 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 11:20:03 INFO - Using env: {'DISPLAY': ':0', 11:20:03 INFO - 'HOME': '/home/cltbld', 11:20:03 INFO - 'LANG': 'en_US.UTF-8', 11:20:03 INFO - 'LANGUAGE': 'en_US:en', 11:20:03 INFO - 'LOGNAME': 'cltbld', 11:20:03 INFO - 'MAIL': '/var/mail/cltbld', 11:20:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:03 INFO - 'MOZ_NO_REMOTE': '1', 11:20:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:03 INFO - 'NO_EM_RESTART': '1', 11:20:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:03 INFO - 'PWD': '/builds/slave/test', 11:20:03 INFO - 'SHELL': '/bin/bash', 11:20:03 INFO - 'SHLVL': '1', 11:20:03 INFO - 'TERM': 'linux', 11:20:03 INFO - 'TMOUT': '86400', 11:20:03 INFO - 'USER': 'cltbld', 11:20:03 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:03 INFO - '_': '/tools/buildbot/bin/python'} 11:20:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:03 INFO - Downloading/unpacking psutil>=0.7.1 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20: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 11:20:05 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 11:20:05 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 11:20:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 11:20:05 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:05 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:05 INFO - Installing collected packages: psutil 11:20:05 INFO - Running setup.py install for psutil 11:20:05 INFO - building 'psutil._psutil_linux' extension 11:20:05 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 11:20:06 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 11:20:06 INFO - building 'psutil._psutil_posix' extension 11:20:06 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 11:20:06 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 11:20:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 11:20:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 11:20:06 INFO - Successfully installed psutil 11:20:06 INFO - Cleaning up... 11:20:06 INFO - Return code: 0 11:20:06 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 11:20:06 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')]} 11:20:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 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')]} 11:20:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:06 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:06 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 11:20:06 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 11:20:06 INFO - Using env: {'DISPLAY': ':0', 11:20:06 INFO - 'HOME': '/home/cltbld', 11:20:06 INFO - 'LANG': 'en_US.UTF-8', 11:20:06 INFO - 'LANGUAGE': 'en_US:en', 11:20:06 INFO - 'LOGNAME': 'cltbld', 11:20:06 INFO - 'MAIL': '/var/mail/cltbld', 11:20:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:06 INFO - 'MOZ_NO_REMOTE': '1', 11:20:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:06 INFO - 'NO_EM_RESTART': '1', 11:20:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:06 INFO - 'PWD': '/builds/slave/test', 11:20:06 INFO - 'SHELL': '/bin/bash', 11:20:06 INFO - 'SHLVL': '1', 11:20:06 INFO - 'TERM': 'linux', 11:20:06 INFO - 'TMOUT': '86400', 11:20:06 INFO - 'USER': 'cltbld', 11:20:06 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:06 INFO - '_': '/tools/buildbot/bin/python'} 11:20:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:06 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 11:20:06 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 11:20:06 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 11:20:06 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 11:20:06 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 11:20:06 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 11:20:06 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 11:20:08 INFO - Downloading mozsystemmonitor-0.0.tar.gz 11:20:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 11:20:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 11:20:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 11:20:08 INFO - Installing collected packages: mozsystemmonitor 11:20:08 INFO - Running setup.py install for mozsystemmonitor 11:20:08 INFO - Successfully installed mozsystemmonitor 11:20:08 INFO - Cleaning up... 11:20:08 INFO - Return code: 0 11:20:08 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 11:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:08 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:08 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 11:20:08 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 11:20:08 INFO - Using env: {'DISPLAY': ':0', 11:20:08 INFO - 'HOME': '/home/cltbld', 11:20:08 INFO - 'LANG': 'en_US.UTF-8', 11:20:08 INFO - 'LANGUAGE': 'en_US:en', 11:20:08 INFO - 'LOGNAME': 'cltbld', 11:20:08 INFO - 'MAIL': '/var/mail/cltbld', 11:20:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:08 INFO - 'MOZ_NO_REMOTE': '1', 11:20:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:08 INFO - 'NO_EM_RESTART': '1', 11:20:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:08 INFO - 'PWD': '/builds/slave/test', 11:20:08 INFO - 'SHELL': '/bin/bash', 11:20:08 INFO - 'SHLVL': '1', 11:20:08 INFO - 'TERM': 'linux', 11:20:08 INFO - 'TMOUT': '86400', 11:20:08 INFO - 'USER': 'cltbld', 11:20:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:08 INFO - '_': '/tools/buildbot/bin/python'} 11:20:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:08 INFO - Downloading/unpacking blobuploader==1.2.4 11:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:10 INFO - Downloading blobuploader-1.2.4.tar.gz 11:20:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 11:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 11:20:10 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:10 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 11:20:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 11:20:10 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:10 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:10 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:11 INFO - Downloading docopt-0.6.1.tar.gz 11:20:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 11:20:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 11:20:11 INFO - Installing collected packages: blobuploader, requests, docopt 11:20:11 INFO - Running setup.py install for blobuploader 11:20:11 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 11:20:11 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 11:20:11 INFO - Running setup.py install for requests 11:20:11 INFO - Running setup.py install for docopt 11:20:11 INFO - Successfully installed blobuploader requests docopt 11:20:11 INFO - Cleaning up... 11:20:11 INFO - Return code: 0 11:20:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:11 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:11 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 11:20:11 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 11:20:11 INFO - Using env: {'DISPLAY': ':0', 11:20:11 INFO - 'HOME': '/home/cltbld', 11:20:11 INFO - 'LANG': 'en_US.UTF-8', 11:20:11 INFO - 'LANGUAGE': 'en_US:en', 11:20:11 INFO - 'LOGNAME': 'cltbld', 11:20:11 INFO - 'MAIL': '/var/mail/cltbld', 11:20:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:11 INFO - 'MOZ_NO_REMOTE': '1', 11:20:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:11 INFO - 'NO_EM_RESTART': '1', 11:20:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:11 INFO - 'PWD': '/builds/slave/test', 11:20:11 INFO - 'SHELL': '/bin/bash', 11:20:11 INFO - 'SHLVL': '1', 11:20:11 INFO - 'TERM': 'linux', 11:20:11 INFO - 'TMOUT': '86400', 11:20:11 INFO - 'USER': 'cltbld', 11:20:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:11 INFO - '_': '/tools/buildbot/bin/python'} 11:20:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:12 INFO - Running setup.py (path:/tmp/pip-KG6uFs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:12 INFO - Running setup.py (path:/tmp/pip-c8TstV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:12 INFO - Running setup.py (path:/tmp/pip-TrIEmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:12 INFO - Running setup.py (path:/tmp/pip-RTNPjw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:12 INFO - Running setup.py (path:/tmp/pip-YF4uo8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:12 INFO - Running setup.py (path:/tmp/pip-rUsXHs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:12 INFO - Running setup.py (path:/tmp/pip-ZT71HY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:12 INFO - Running setup.py (path:/tmp/pip-R6GL3n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:12 INFO - Running setup.py (path:/tmp/pip-vkWbyQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:12 INFO - Running setup.py (path:/tmp/pip-BvMVrB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:12 INFO - Running setup.py (path:/tmp/pip-9htcyU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:12 INFO - Running setup.py (path:/tmp/pip-2uVzBK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:12 INFO - Running setup.py (path:/tmp/pip-6Za6PT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:12 INFO - Running setup.py (path:/tmp/pip-kM5kPU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:13 INFO - Running setup.py (path:/tmp/pip-K3E_XF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:13 INFO - Running setup.py (path:/tmp/pip-tMjtGa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:13 INFO - Running setup.py (path:/tmp/pip-zm5CyB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:13 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 11:20:13 INFO - Running setup.py install for manifestparser 11:20:13 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 11:20:13 INFO - Running setup.py install for mozcrash 11:20:13 INFO - Running setup.py install for mozdebug 11:20:13 INFO - Running setup.py install for mozdevice 11:20:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 11:20:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 11:20:13 INFO - Running setup.py install for mozfile 11:20:13 INFO - Running setup.py install for mozhttpd 11:20:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 11:20:13 INFO - Running setup.py install for mozinfo 11:20:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 11:20:13 INFO - Running setup.py install for mozInstall 11:20:14 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Running setup.py install for mozleak 11:20:14 INFO - Running setup.py install for mozlog 11:20:14 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Running setup.py install for moznetwork 11:20:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Running setup.py install for mozprocess 11:20:14 INFO - Running setup.py install for mozprofile 11:20:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Running setup.py install for mozrunner 11:20:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Running setup.py install for mozscreenshot 11:20:14 INFO - Running setup.py install for moztest 11:20:14 INFO - Running setup.py install for mozversion 11:20:14 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 11:20:14 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 11:20:14 INFO - Cleaning up... 11:20:15 INFO - Return code: 0 11:20:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:15 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 11:20:15 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 11:20:15 INFO - Using env: {'DISPLAY': ':0', 11:20:15 INFO - 'HOME': '/home/cltbld', 11:20:15 INFO - 'LANG': 'en_US.UTF-8', 11:20:15 INFO - 'LANGUAGE': 'en_US:en', 11:20:15 INFO - 'LOGNAME': 'cltbld', 11:20:15 INFO - 'MAIL': '/var/mail/cltbld', 11:20:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:15 INFO - 'MOZ_NO_REMOTE': '1', 11:20:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:15 INFO - 'NO_EM_RESTART': '1', 11:20:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:15 INFO - 'PWD': '/builds/slave/test', 11:20:15 INFO - 'SHELL': '/bin/bash', 11:20:15 INFO - 'SHLVL': '1', 11:20:15 INFO - 'TERM': 'linux', 11:20:15 INFO - 'TMOUT': '86400', 11:20:15 INFO - 'USER': 'cltbld', 11:20:15 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:15 INFO - '_': '/tools/buildbot/bin/python'} 11:20:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 11:20:15 INFO - Running setup.py (path:/tmp/pip-avAe1G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 11:20:15 INFO - Running setup.py (path:/tmp/pip-BFnt1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 11:20:15 INFO - Running setup.py (path:/tmp/pip-X8dcaQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 11:20:15 INFO - Running setup.py (path:/tmp/pip-6E8tHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 11:20:15 INFO - Running setup.py (path:/tmp/pip-JdbbA1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 11:20:15 INFO - Running setup.py (path:/tmp/pip-PRNURa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 11:20:15 INFO - Running setup.py (path:/tmp/pip-wVx_Q7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 11:20:15 INFO - Running setup.py (path:/tmp/pip-iK_w1J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 11:20:15 INFO - Running setup.py (path:/tmp/pip-eXQm35-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 11:20:15 INFO - Running setup.py (path:/tmp/pip-IAfShG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 11:20:15 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)) 11:20:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 11:20:15 INFO - Running setup.py (path:/tmp/pip-SH_GIk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 11:20:16 INFO - Running setup.py (path:/tmp/pip-kya55b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 11:20:16 INFO - Running setup.py (path:/tmp/pip-2F64sk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 11:20:16 INFO - Running setup.py (path:/tmp/pip-w7xIbl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:16 INFO - Running setup.py (path:/tmp/pip-oFUoW8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 11:20:16 INFO - Running setup.py (path:/tmp/pip-pFsKbM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 11:20:16 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)) 11:20:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 11:20:16 INFO - Running setup.py (path:/tmp/pip-yi3v42-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 11:20:16 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)) 11:20:16 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)) 11:20:16 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)) 11:20:16 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)) 11:20:16 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)) 11:20:16 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)) 11:20:16 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 11:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 11:20:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 11:20:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 11:20:18 INFO - Downloading blessings-1.5.1.tar.gz 11:20:18 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 11:20:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 11:20:18 INFO - Installing collected packages: blessings 11:20:18 INFO - Running setup.py install for blessings 11:20:18 INFO - Successfully installed blessings 11:20:18 INFO - Cleaning up... 11:20:18 INFO - Return code: 0 11:20:18 INFO - Done creating virtualenv /builds/slave/test/build/venv. 11:20:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:18 INFO - Reading from file tmpfile_stdout 11:20:18 INFO - Current package versions: 11:20:18 INFO - argparse == 1.2.1 11:20:18 INFO - blessings == 1.5.1 11:20:18 INFO - blobuploader == 1.2.4 11:20:18 INFO - docopt == 0.6.1 11:20:18 INFO - manifestparser == 1.1 11:20:18 INFO - mozInstall == 1.12 11:20:18 INFO - mozcrash == 0.16 11:20:18 INFO - mozdebug == 0.1 11:20:18 INFO - mozdevice == 0.47 11:20:18 INFO - mozfile == 1.2 11:20:18 INFO - mozhttpd == 0.7 11:20:18 INFO - mozinfo == 0.9 11:20:18 INFO - mozleak == 0.1 11:20:18 INFO - mozlog == 3.1 11:20:18 INFO - moznetwork == 0.27 11:20:18 INFO - mozprocess == 0.22 11:20:18 INFO - mozprofile == 0.27 11:20:18 INFO - mozrunner == 6.11 11:20:18 INFO - mozscreenshot == 0.1 11:20:18 INFO - mozsystemmonitor == 0.0 11:20:18 INFO - moztest == 0.7 11:20:18 INFO - mozversion == 1.4 11:20:18 INFO - psutil == 3.1.1 11:20:18 INFO - requests == 1.2.3 11:20:18 INFO - wsgiref == 0.1.2 11:20:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 11:20:18 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')]} 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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')]} 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:18 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 11:20:18 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 11:20:18 INFO - Using env: {'DISPLAY': ':0', 11:20:18 INFO - 'HOME': '/home/cltbld', 11:20:18 INFO - 'LANG': 'en_US.UTF-8', 11:20:18 INFO - 'LANGUAGE': 'en_US:en', 11:20:18 INFO - 'LOGNAME': 'cltbld', 11:20:18 INFO - 'MAIL': '/var/mail/cltbld', 11:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:18 INFO - 'MOZ_NO_REMOTE': '1', 11:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:18 INFO - 'NO_EM_RESTART': '1', 11:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:18 INFO - 'PWD': '/builds/slave/test', 11:20:18 INFO - 'SHELL': '/bin/bash', 11:20:18 INFO - 'SHLVL': '1', 11:20:18 INFO - 'TERM': 'linux', 11:20:18 INFO - 'TMOUT': '86400', 11:20:18 INFO - 'USER': 'cltbld', 11:20:18 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:18 INFO - '_': '/tools/buildbot/bin/python'} 11:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 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)) 11:20:18 INFO - Cleaning up... 11:20:18 INFO - Return code: 0 11:20:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 11:20:18 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')]} 11:20:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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')]} 11:20:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:18 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:18 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 11:20:18 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 11:20:18 INFO - Using env: {'DISPLAY': ':0', 11:20:18 INFO - 'HOME': '/home/cltbld', 11:20:18 INFO - 'LANG': 'en_US.UTF-8', 11:20:18 INFO - 'LANGUAGE': 'en_US:en', 11:20:18 INFO - 'LOGNAME': 'cltbld', 11:20:18 INFO - 'MAIL': '/var/mail/cltbld', 11:20:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:18 INFO - 'MOZ_NO_REMOTE': '1', 11:20:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:18 INFO - 'NO_EM_RESTART': '1', 11:20:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:18 INFO - 'PWD': '/builds/slave/test', 11:20:18 INFO - 'SHELL': '/bin/bash', 11:20:18 INFO - 'SHLVL': '1', 11:20:18 INFO - 'TERM': 'linux', 11:20:18 INFO - 'TMOUT': '86400', 11:20:18 INFO - 'USER': 'cltbld', 11:20:18 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:18 INFO - '_': '/tools/buildbot/bin/python'} 11:20:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:18 INFO - Downloading/unpacking jsonschema 11:20:18 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 11:20:18 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 11:20:18 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 11:20:18 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 11:20:18 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 11:20:18 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 11:20:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 11:20:20 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 11:20:20 INFO - Downloading/unpacking functools32 (from jsonschema) 11:20:20 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 11:20:20 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 11:20:20 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 11:20:20 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 11:20:20 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 11:20:20 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 11:20:20 INFO - Downloading functools32-3.2.3-2.tar.gz 11:20:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 11:20:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 11:20:20 INFO - warning: no files found matching '*.txt' 11:20:20 INFO - no previously-included directories found matching 'build' 11:20:20 INFO - no previously-included directories found matching 'dist' 11:20:20 INFO - no previously-included directories found matching '.git*' 11:20:20 INFO - Installing collected packages: jsonschema, functools32 11:20:20 INFO - Running setup.py install for functools32 11:20:21 INFO - warning: no files found matching '*.txt' 11:20:21 INFO - no previously-included directories found matching 'build' 11:20:21 INFO - no previously-included directories found matching 'dist' 11:20:21 INFO - no previously-included directories found matching '.git*' 11:20:21 INFO - Successfully installed jsonschema functools32 11:20:21 INFO - Cleaning up... 11:20:21 INFO - Return code: 0 11:20:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 11:20:21 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')]} 11:20:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 11:20:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:21 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')]} 11:20:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 11:20:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 11:20:21 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 0x7ff800731f10>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2ba08a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c6e240>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, '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-1449688595.233271-1160338425', '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 11:20:21 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 11:20:21 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 11:20:21 INFO - Using env: {'DISPLAY': ':0', 11:20:21 INFO - 'HOME': '/home/cltbld', 11:20:21 INFO - 'LANG': 'en_US.UTF-8', 11:20:21 INFO - 'LANGUAGE': 'en_US:en', 11:20:21 INFO - 'LOGNAME': 'cltbld', 11:20:21 INFO - 'MAIL': '/var/mail/cltbld', 11:20:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:21 INFO - 'MOZ_NO_REMOTE': '1', 11:20:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:21 INFO - 'NO_EM_RESTART': '1', 11:20:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:21 INFO - 'PWD': '/builds/slave/test', 11:20:21 INFO - 'SHELL': '/bin/bash', 11:20:21 INFO - 'SHLVL': '1', 11:20:21 INFO - 'TERM': 'linux', 11:20:21 INFO - 'TMOUT': '86400', 11:20:21 INFO - 'USER': 'cltbld', 11:20:21 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:21 INFO - '_': '/tools/buildbot/bin/python'} 11:20:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 11:20:21 INFO - Downloading/unpacking flake8 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:21 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 11:20:22 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 11:20:22 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 11:20:23 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 11:20:23 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 11:20:23 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 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 11:20:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpep8-1.5.7.tar.gz 11:20:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 11:20:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:23 INFO - no previously-included directories found matching 'docs/_build' 11:20:23 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 11:20:23 INFO - Running setup.py install for pep8 11:20:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 11:20:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 11:20:23 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 11:20:23 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 11:20:23 INFO - no previously-included directories found matching 'docs/_build' 11:20:23 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 11:20:23 INFO - Successfully installed flake8 mccabe pyflakes pep8 11:20:23 INFO - Cleaning up... 11:20:23 INFO - Return code: 0 11:20:23 INFO - Running post-action listener: _resource_record_post_action 11:20:23 INFO - Running post-action listener: _start_resource_monitoring 11:20:23 INFO - Starting resource monitoring. 11:20:23 INFO - ##### 11:20:23 INFO - ##### Running install step. 11:20:23 INFO - ##### 11:20:23 INFO - Running pre-action listener: _resource_record_pre_action 11:20:23 INFO - Running main action method: install 11:20:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 11:20:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 11:20:24 INFO - Reading from file tmpfile_stdout 11:20:24 INFO - Detecting whether we're running mozinstall >=1.0... 11:20:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 11:20:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 11:20:24 INFO - Reading from file tmpfile_stdout 11:20:24 INFO - Output received: 11:20:24 INFO - Usage: mozinstall [options] installer 11:20:24 INFO - Options: 11:20:24 INFO - -h, --help show this help message and exit 11:20:24 INFO - -d DEST, --destination=DEST 11:20:24 INFO - Directory to install application into. [default: 11:20:24 INFO - "/builds/slave/test"] 11:20:24 INFO - --app=APP Application being installed. [default: firefox] 11:20:24 INFO - mkdir: /builds/slave/test/build/application 11:20:24 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'] 11:20:24 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 11:20:38 INFO - Reading from file tmpfile_stdout 11:20:38 INFO - Output received: 11:20:38 INFO - /builds/slave/test/build/application/firefox/firefox 11:20:38 INFO - Running post-action listener: _resource_record_post_action 11:20:38 INFO - ##### 11:20:38 INFO - ##### Running run-tests step. 11:20:38 INFO - ##### 11:20:38 INFO - Running pre-action listener: _resource_record_pre_action 11:20:38 INFO - Running main action method: run_tests 11:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 11:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 11:20:38 INFO - Python 2.7.3 11:20:38 INFO - Return code: 0 11:20:38 INFO - grabbing minidump binary from tooltool 11:20:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 11:20:38 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 0x2cfd0b0>, '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 0x2cfdfb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cfe440>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 11:20:38 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 11:20:38 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 11:20:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 11:20:38 INFO - Return code: 0 11:20:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 11:20:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 11:20:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 11:20:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 11:20:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 11:20:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 11:20:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 11:20:39 INFO - Return code: 0 11:20:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:20:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 11:20:39 INFO - Using env: {'DISPLAY': ':0', 11:20:39 INFO - 'HOME': '/home/cltbld', 11:20:39 INFO - 'LANG': 'en_US.UTF-8', 11:20:39 INFO - 'LANGUAGE': 'en_US:en', 11:20:39 INFO - 'LOGNAME': 'cltbld', 11:20:39 INFO - 'MAIL': '/var/mail/cltbld', 11:20:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 11:20:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 11:20:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 11:20:39 INFO - 'MOZ_NO_REMOTE': '1', 11:20:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 11:20:39 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 11:20:39 INFO - 'NO_EM_RESTART': '1', 11:20:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 11:20:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 11:20:39 INFO - 'PWD': '/builds/slave/test', 11:20:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 11:20:39 INFO - 'SHELL': '/bin/bash', 11:20:39 INFO - 'SHLVL': '1', 11:20:39 INFO - 'TERM': 'linux', 11:20:39 INFO - 'TMOUT': '86400', 11:20:39 INFO - 'USER': 'cltbld', 11:20:39 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1449688595.233271-1160338425', 11:20:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 11:20:39 INFO - '_': '/tools/buildbot/bin/python'} 11:20:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/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 11:20:39 INFO - mozversion INFO | application_buildid: 20151209104438 11:20:39 INFO - mozversion INFO | application_changeset: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 11:20:39 INFO - mozversion INFO | application_display_name: Nightly 11:20:39 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 11:20:39 INFO - mozversion INFO | application_name: Firefox 11:20:39 INFO - mozversion INFO | application_remotingname: firefox 11:20:39 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 11:20:39 INFO - mozversion INFO | application_vendor: Mozilla 11:20:39 INFO - mozversion INFO | application_version: 45.0a1 11:20:39 INFO - mozversion INFO | platform_buildid: 20151209104438 11:20:39 INFO - mozversion INFO | platform_changeset: 575efef2e8cdd0cba6ad58958a44db2f5f2c72c8 11:20:39 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 11:20:39 INFO - mozversion INFO | platform_version: 45.0a1 11:20:39 INFO - 2015-12-09 11:20:39,962 DEBUG : using testdate: 1449688839 11:20:39 INFO - 2015-12-09 11:20:39,962 DEBUG : actual date: 1449688839 11:20:40 INFO - 2015-12-09 11:20:40,077 INFO : starting webserver on 'localhost:57690' 11:20:40 INFO - 2015-12-09 11:20:40,078 INFO : Starting test suite talos-linux64-ix-055 11:20:40 INFO - 2015-12-09 11:20:40,078 INFO : Starting test dromaeo_css 11:20:40 INFO - 2015-12-09 11:20:40,078 DEBUG : operating with platform_type : linux_ 11:20:40 INFO - 2015-12-09 11:20:40,079 INFO : Initialising browser for dromaeo_css test... 11:20:40 INFO - 2015-12-09 11:20:40,096 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6LsfSg/profile http://localhost:57690/getInfo.html 11:20:44 INFO - 2015-12-09 11:20:44,639 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:20:44 INFO - 2015-12-09 11:20:44,639 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:20:44 INFO - 2015-12-09 11:20:44,639 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:20:44 INFO - 2015-12-09 11:20:44,640 DEBUG : BROWSER_OUTPUT: __metrics 11:20:44 INFO - 2015-12-09 11:20:44,716 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] 11:20:44 INFO - 2015-12-09 11:20:44,784 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:20:45 INFO - 2015-12-09 11:20:45,816 INFO : Browser initialized. 11:20:45 INFO - 2015-12-09 11:20:45,817 INFO : Running cycle 1/1 for dromaeo_css test... 11:20:45 INFO - 2015-12-09 11:20:45,817 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp6LsfSg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:20:57 INFO - 2015-12-09 11:20:57,821 DEBUG : BROWSER_OUTPUT: RSS: Main: 142671872 11:20:57 INFO - 2015-12-09 11:20:57,821 DEBUG : BROWSER_OUTPUT: 11:21:49 INFO - 2015-12-09 11:21:49,188 DEBUG : BROWSER_OUTPUT: 1449688909184 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] 11:24:01 INFO - 2015-12-09 11:24:01,193 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57690/tests/dromaeo/cssquery-ext.html) 11:24:02 INFO - 2015-12-09 11:24:02,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 254537728 11:24:02 INFO - 2015-12-09 11:24:02,305 DEBUG : BROWSER_OUTPUT: 11:27:04 INFO - 2015-12-09 11:27:04,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-ext.html (next: http://localhost:57690/tests/dromaeo/cssquery-jquery.html) 11:27:05 INFO - 2015-12-09 11:27:05,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 222601216 11:27:05 INFO - 2015-12-09 11:27:05,403 DEBUG : BROWSER_OUTPUT: 11:30:07 INFO - 2015-12-09 11:30:07,428 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57690/tests/dromaeo/cssquery-mootools.html) 11:30:08 INFO - 2015-12-09 11:30:08,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 214794240 11:30:08 INFO - 2015-12-09 11:30:08,017 DEBUG : BROWSER_OUTPUT: 11:33:09 INFO - 2015-12-09 11:33:09,967 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57690/tests/dromaeo/cssquery-prototype.html) 11:33:10 INFO - 2015-12-09 11:33:10,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 202219520 11:33:10 INFO - 2015-12-09 11:33:10,541 DEBUG : BROWSER_OUTPUT: 11:36:13 INFO - 2015-12-09 11:36:13,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57690/tests/dromaeo/cssquery-yui.html) 11:36:13 INFO - 2015-12-09 11:36:13,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 208179200 11:36:13 INFO - 2015-12-09 11:36:13,811 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,330 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/dromaeo/cssquery-yui.html (next: http://localhost:57690/tests/dromaeo/cssquery-dojo.html) 11:39:16 INFO - 2015-12-09 11:39:16,588 DEBUG : BROWSER_OUTPUT: RSS: Main: 249159680 11:39:16 INFO - 2015-12-09 11:39:16,588 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,588 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2640.4851054044457;2748.738869807368;2749.738774816394;2754.600582915476;2779.6386469758927;4330.458692663417;4497.055618320157;4735.5264473552625;4773.594244489218;4795.496472870346;4594.218982772928;4645.256758918574;4682.836100736475;4687.882802929928;4739.312799644058;4168.166366726652;4317.0934103838235;4317.13657268546;4388.802503887317;4407.316865885793;4382.298832186851;4444.177827101997;4445.666575006888;4446.533114023029;4480.731156130642;4185.727927684721;4236.301010333276;4303.440552728157;4350.782460876943;4355.673324500675;4332.610065094157;4377.824887004516;4379.430674012358;4382.035952090535;4413.845515406945;4361.890952726176;4364.803583838735;4367.192069467159;4380.60574548289;4394.802233899482;4424.889377765549;4507.549245075499;4525.570070843298;4592.196365636034;4734.644901632391;5137.38351397831;5156.458571849939;5157.252198431206;5158.148905430637;5164.2770012198325;5176.430592634807;5180.844574662766;5184.559312458446;5214.426413094557;5234.842954711365;4434.534373890728;4542.432195975503;4546.499885012646;4665.790039448233;4762.357081793983;5198.2722418861385;5256.448072952285;5267.868303292372;5268.841934741964;5270.7628156733035;5021.322121513622;5035.748212589356;5046.369203849519;5049.368828896388;5087.465816089331;4865.197242454955;4962.478939711351;4964.67729597575;4970.478099799541;5113.718745469035;5031.119554078022;5033.3205017322925;5036.748162591855;5038.546530812245;5071.340725705709;5059.19052951526;5059.544640982329;5066.113430149709;5066.797328106908;5122.590192784568;4031.992331426154;4120.670346372283;4193.874183774492;4206.326987681956;4296.914061718748;3651.1419816343137;3671.320805650963;3698.7595806272507;3704.9259014819554;3739.439084137401;4372.431583894074;4373.365861949999;4378.2119218540965;4387.692861499664;4414;4824.0834241494;4927.901441971212;4938.802447902115;4998.4251811042195;5139.280500729901;4324.437823083042;4329.913401732011;4330.242207613655;4336.804843782037;4344.9565504344555;4498.955010449854;4507.797149128297;4510.526394728572;4518.909621807611;4548.135854187693;4584.174848527297;4719.504452032487;4736.455307639666;4736.597389221817;4814.20565606671;5086.54221120101;5101.92347114801;5106.719130447861;5108.463611320758;5116.4627714090975;4824.903501930012;4830.541098595628;4832.130216561053;4839.225723884161;4868.902621947612;4746.38297021385;4852.1508735971765;4855.975720121377;4954.1825598775795;5078.441371449211;5093.955739073555;5100.464451232567;5113.15632920564;5120.667156634807;5126.79492820283;4933.284673722218;4936.753162341796;4936.827211047596;4942.135126352946;4987.625928055338;4666.11343844682;4718.127146477913;4764.618830493621;4767.976160119178;4918.336024636628;4850.078485087822;4864.075825593126;4870.050340183772;4874.658773885936;4904.485029071896;4980.626453016111;4988.077205716954;4988.301637770787;4993.101241776515;5006.549410553068;4611.723296602215;4720.079584480994;4720.645951553716;4724.078804633064;4854.9514504855915 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |1;ext.html;520.9192575150852;530.2655821686963;531.9228711836784;545.9372172200195;547.384192783119;27109.322266943313;28358.716412835867;36841.44737828931;37642.62357376426;37692.62307376925;42398.78800606;42489.787551062276;42748.14503709924;42885;43041;7096.6806493707645;7973.561454120036;8158.877616835753;8161.5919204039565;8183.386246031541;7218.133823941108;10211.081002709754;10505.474726263694;10514.474276286155;10514.474276286193;10234.23243256755;10323.638672646459;10330.89669103307;10337.483125843715;10347.275690701654;7225.5664660120565;7487.475876688634;10058.195344372432;10223.48882555873;10347.327423717434;10054.396736195778;10212;10215.336003159771;10220.591176352937;10228.38629682214;38681.806590966866;39250;39269;39299;39318.60681393178;2915.2566095645475;2919.474494590973;2923.751481124107;2954.5863579098946;2961.526155815081;28626.856865715745;28957.85521072402;29160.854195729098;29182;29452.26369340762;3325.6840600142946;3339.131825725329;3368.360011597789;3370.4607262837826;3461.4807778833124;217528;218761;218798;218948;219784;53052.20421693678;54738.45261547413;58082.70958645264;58554.70722646359;62540.37459625345;56470.43529564734;56531;56683.716581416826;56732.865342692916;56743;14988.40046398132;15338.923305383401;15351.462698805488;15352.078875267296;15361.46234881796;11479.770404592029;11667.766644667228;11683.182177247681;11683.707907302385;11689.181757276909;19273.22907083729;19542.31601893927;19684.70472942907;19728.802711972985;19826.306079287155;7444.367228785614;7552.622368881534;7625.542467451971;7642.815363618648;7672.232776722395;860.1183786618766;916.6470908700065;1010.3988127064385;1016.8118898003893;1082.9783404332027;27196;27474.862625686743;27486.725132748816;27551;27728.445431091266;935.9204467620192;992.3103443106971;992.5731935267904;1001.8697569316088;1047.177965297238;13126.212427254204;13447;13482.191068535723;13507.257100859548;13575.932120339336;287028;292338;293179;293283;293795;47336;47584;47594.762026189645;47667.523324766305;47704.28443573349;1223.590097317391;1229.4098832560242;1229.8647148813623;1233.771752225859;1241.8571864235728;24542.509149817262;24784.50430991406;24934.50130997406;25168.119115830857;25185.874070630263;38790;39110.6088939107;39142.93284540901;39214;39244.2151156981;256410;257282;258953;259641;260016;26428.339291517095;26867.86566067157;28269.434611307246;29286.560701589067;29544.852275739344;37218.25563488769;37290.254194915404;37409.625903741704;38043.23913521769;38074.23851523009;32208.516872247405;32466.83766581152;32956.1760955978;33623.48694308811;33761.324773503904;27750.5837412443;30034.24914377158;32202.516962245118;32693.34613307768;32935.835320823244;31441.8427907859;33024;33039.50440743439;33656.1585960353;33756;29333.41333173282;29686.406271874872;30025;30176.84911575428;30217.69782302237;23170.652440213747;23262.3021309361;23536.6469502961;23771.1680091196;23835.284941451784 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |2;jquery.html;269.6615747237217;271.4232256455033;271.5438064052392;276.1164274322169;276.6003125483677;10529.029496458868;15156.242187890603;15531.223438828041;15565.455209067684;17053.232604532794;16205.91897040516;16332.34670613174;16510.752338714898;16514;16759.329626814942;5414.539764120044;5548.86127846803;5563.777448902059;5569.081101618228;5574.944250557503;5513.8345849624575;5559.3328800543995;5559.77760889566;5566.2207290979095;5567.248421463111;4017.076072503326;4133.627973482386;5406.729663516828;5531.917021244684;6239.313675495692;6281.780137695182;6308.842278943063;6315.021171718391;6363.204599425072;6365.554411191241;5993.482737250365;6085.4523092921845;6461.321561236096;6467.579607325509;6475.222973243194;19614.117364718622;19998.100085496186;20393.694094588594;20554.58890822175;20583.279585214594;1957.3247229705728;1985.682290833474;2023.6660950943076;2042.1218875883364;2124.8406369522195;8308.833823323499;8649.178328058888;13159.736805263841;13303.467861285537;13910;1752.5793809485758;1756.0341812003346;1773.4147731248786;1783.3312507809571;1799.7390378395191;54801.1779823303;56453.71773141108;57181.85226846644;57573.99999999958;57901.05187377542;9513.143817056498;9549.474778887088;9560;9573.425594464354;9577.23382129428;11954.342511161969;11957.162998590189;11964.940175299242;11969;11970.281783093042;6876.071730316443;6893.034975103489;7134.32223938725;7161.606111663804;7215.06204193462;6848.520603557703;7031.824204394931;7044.718211271492;7057.788266352018;7122.679479423438;3960.5445373782386;3963.02905788078;3969.801509924492;3975.7813320267082;4049.3521036633997;1630.8450697183748;1638.1399765123406;1642.91785410729;1651.1661610886426;1672.7072762266555;695.3950063444735;782.1474592693877;796.7330944133664;814.5560669435172;914.1681070226063;14679.19264440466;15324.463643772637;15623.296951637203;16286;16564.171791410383;726.9273072692688;804.8028233082932;832.2967092806568;869.3219288954499;889.5063239901916;8087.0295564532635;8325.708600198965;8599.699010534601;9035.728928132166;9267.860982085274;512296;515313;515497;519405;522819;74033.25966740264;75007.62496187484;75323.62338188384;76297;76359.61820190975;1077.186724023373;1086.8858769829212;1093.1309608861134;1094.895984881435;1096.0190629386655;15160.31778569989;15220.315085821387;15250.542483725507;15390.461333853262;15477.922610386877;30801.229969250053;30871;32370;32455.188620284684;34534.13664658403;37336.25327493489;37767.81116094402;37823.621763783114;39307.410388843615;39488.2102357957;8421.368397370345;8556.529390883312;8710.82578348442;8943.23982461472;8954.820903582022;16248.700103991416;16387;16570.171491425623;16609.833901661314;16938.83061169422;10769.569217231223;11171.776564468502;13576.660583485096;14447.133172009713;14601.561953141423;11643.53425862956;13541.187528748307;14018.336516061916;14197.858021420067;14493.130412175304;14520.983531152719;14612.707745845237;14627.122372657675;15018.849811502183;15104.924475377553;8781.648734050566;8846.115388461103;8919.73240802777;8926;8950.104989500998;9262.44425334482;12759.744805104032;14146.080504767157;14311.427542898167;14480.131192128507 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1431.4775107085916;1641.0891954964998;1688.5609741467222;1710.8460238578525;1711.6833385823616;5771.624844385117;7080.610566418852;7254.455915806322;7256.6371681415985;7271.200167981525;7089.22018577956;7287.562746235217;7293.781186564412;7339.009233753442;7340.339369456748;1713.8800283980127;1738.400251913088;1739;2008.7890771468967;2049.415916463808;1999.4601457606439;2038.7247721557549;2050.0877109686194;2052.5586998795256;2055.424481145282;1938.4959910423322;1952.9804701953012;1955.4720225539095;2011.054804242004;2013.1745984146503;1971.7338159348592;1985.4837742186992;2007.7791442941266;2015.8185763281301;2017.0217444539387;2056.074766355146;2083.7707852136255;2084.062172022596;2085.572457646179;2086.822620077295;7130.679119439637;7249.311315425026;7256.129264488242;7258.056452661173;7265.673044712948;4112.547619761824;4138.793060347;4207.284761590537;4209.6421804146685;4210.442136409548;2700.972990270092;2746.8489233092173;2759.7378249066305;2768.045024466556;2783.6520434945633;806.2219957740749;845.1168528887266;850.9149085091503;851.6635928808148;879.9736007919709;9748.658796942073;9752.4636145012;9753.707388778277;9758.219342452587;9768.755781105529;3737.7757334560015;3773.547174339042;3851.5763266040713;3856.46009558662;3858.093348063203;8427;8432.283255923192;8435.536045517556;8438.493690378597;8442.873356899652;4249.68127390447;4264.061906380592;4273.7008409411665;4275.3800698898485;4287.742735435884;3892.552356479041;3904.4338570907626;3908.1988192420486;3912.0415498203124;3919.510061242345;2867;2907.4911890419094;3094.1181763197383;3362.65493802481;3464.8440820163155;1031.8813336466253;1040.765827688764;1041.2294901772784;1042.9895701043044;1043.4052590023766;899.2221728205055;912.9726108216764;914.1863741270275;916.2349438219028;1174.236746115015;6848.623325717133;6973.302669732986;6974.965125174342;6980.336867997532;6987.301269872972;1044.2951008069522;1099.3349023840622;1122.3770807201918;1141.4749215360862;1151.585429245471;5074.3657042869645;5398.676079435168;5412.052890744104;5413.431589683105;5424.05079111154;8125.593720313961;8202.507849528927;8318.45930014547;8368.456050356708;8386.538740369338;8281.751547453587;8340.37447191463;8351.3736469765;8390.832183356299;8410.957945210235;6575.671216439159;6608.669566521655;6672.499562532829;6677.198736151596;6680.198376194888;6341.682915854097;6557.147570815763;6561.934380656323;6575.24384695747;6575.835604109936;7321.414286856932;7414.480986330905;7574.659140338587;7684.769456916301;7689.423293252917;7654.272844079804;7855.567943763148;7861.213878612093;7864.72473463426;7922.366210703245;6107.175531303217;6170.845728856814;6195.16365290698;6198.163247961467;6201.689915504297;5535.363433205233;5631.746571404378;6842.55523390978;6936.028955946071;6981.406580440719;6490.383413575702;6530.379613936669;6568.310327415553;6578.276389597045;6621.370969757865;6285.717142728497;6339.397757213057;6347.111404403479;6467.094606754964;6486.027095935648;5898.94101058984;6006.459418652167;6011.458968692838;6046.123312119806;6068.029115341524;6080.847978800389;6138.324784273816;6139.447449729546;6142.78500252489;6149.139120523219;6137.723802428812;6185.84535386619;6214.25428948529;6239.188905442264;6269.028300613412 11:39:16 INFO - 2015-12-09 11:39:16,589 DEBUG : BROWSER_OUTPUT: |4;prototype.html;254.53801350548756;257.85946659070805;258.3373646596481;259.4266670657846;261.50314402635;5295.0468915595175;5326.520613144816;5340.145576707722;5345.091334473139;5388.191771234317;4849.660523763338;4952.529509696573;5141.15170996786;5250.632455728091;5272.446393128724;4021.3967904814367;4023.6579890709327;4028.6777057835448;4036.3945408188715;4041.1917616476676;4027.3556231003045;4039.4546736190678;4043.595640435962;4046.858359957402;4052.8378864845517;3796.6393192646656;3868.071662800936;3883.456316115746;3912.941305880414;3962.405639154121;3955.3671412573995;3972.841086356557;3987.3819557968563;3997.780122093284;4000.4799376080923;3448.1207292140343;3455.6198818129988;3457.0320310313155;3459.844307006191;3462.480627905809;5111.795528178905;5113.105206588869;5114.590832733373;5118.206677964921;5118.667286626357;4481.260592002316;4551.112533056055;4566.06395688883;4572.337011133401;4572.862814115582;5528.861778455531;5536.390996990328;5542;5542.75057622408;5545.639533430314;3748.3440397930253;3753.380692185786;3753.7935413552245;3754.906127346811;3756;5846.152307915371;5846.678432686201;5847.736851841677;5853.1220316952795;5855.385184555603;3716.1824398632257;3838.4242363645676;3861.4593956846065;3862.806859657062;3862.9227415452096;3893.844246230176;3908.7263891527887;3909.0422846402244;3909.843606255775;3913.726039177287;4538.001639639274;4541.364209010675;4547.431571053618;4550.453945526558;4553.840615578439;5571.693556854331;5573.721313934287;5573.916391254134;5575.470330318613;5575.553955683536;1349.1500354776429;1367.7606418876658;1367.856375080622;1369.0074695845433;1369.8493165751759;903.2277402820494;905.7011186308634;928.9535523223811;934.5934518484481;940.3088729783603;4778.4982576829625;4810.037992401533;4814.109389762905;4816.20532612122;4819.6867203631655;5738.626989245686;5742.138679198154;5744.425557444222;5747.798827041033;5750.079987202112;4653.976730116327;4759.547842954914;4801.831935882297;4809.879753006203;4817.855464336076;3019.89430369936;3100.9844950775555;3109.0517392195147;3113.8910138145056;3123.359711259232;5461.699606521679;5482.068048431776;5490.780368785284;5499.065158922913;5502.642328248651;5990.400959903975;5992.820215393545;5993.910091348634;5994.400559943971;5999.190109335271;5293.179557168645;5483.150111732688;5516.365617953907;5521.861953451196;5526.447355264441;5838.12428135783;5848.766049357978;5854.765809367577;5855.502282305882;5856.004479238454;5699.0311647020935;5702.429757024264;5703.515201207778;5710.428957104256;5710.828675139753;5336.412994570672;5491.615586908878;5509.807156749494;5513.751881165277;5521.420250873761;3730.0674831292176;3755.943660845144;3758.8684396046006;3760.7743535387963;3762.266358060152;5826.067829147316;5836.182934389104;5847.44449277318;5849.093390524476;5856.853578660397;5610.242617246783;5624.74688639004;5628.324601047901;5637.295338082739;5647.407022262603;5409.323109835964;5556.444355564411;5617.634853734494;5625.381208067028;5634.070378387521;5523.861903452285;5524.088525393265;5535.723213839211;5537.6954267515675;5540.501354878081;5675.858103547279;5679.233303503974;5681.204631351697;5681.375048744552;5690.544756419559;5434.864128396822;5506.394296627288;5522.144067669517;5551.417101204315;5556.138798486241 11:39:16 INFO - 2015-12-09 11:39:16,590 DEBUG : BROWSER_OUTPUT: |5;yui.html;649.9675016249192;652.1489456259583;717.4905816870022;721.5382155420535;755.3466251692286;11655.533778648844;14139.29303534823;14292.713655770978;14432.5670229893;14439.783403248934;13031.283279419627;13494.25781582015;13499.932500337485;13512.05415620907;13538.39077241524;623.8284471770277;628.4846425930739;782.8903953446522;798.0144521515923;799.580220384297;799.6401619271322;806.7055524733489;810.8702607582788;812.8780682897553;813.1299509524811;836.2348451167175;850.7447765670305;851.1020872979004;851.1701091435863;851.2721623012328;656.1764984943889;664.139938779282;809.4374409785202;830.5307501261768;848.1179573243819;613.2181468627535;615.4184295840432;616.1927874484395;617.3486971245335;617.6448542088317;12362.938185309016;12666.746665066647;12676.556320528738;12678.239305641599;12691.746165076647;10232.89767102327;11650;11737.413129343584;11830.645080647595;11941.343226122559;9752.90247097527;9852.95073524635;9863.60545578176;9913;10017.248706347053;3247.220667039917;3268.166617512543;3282.097423208637;3306.0908250231137;3408.5739282589675;39670.60329396698;41782;41812;41911.95220119491;41981.1603767926;9329.766755831159;9526.095020972996;9544.761380965532;9559.091886270793;9765.414075155513;15495.45765898188;15609;15681.764773528406;15697.843021569866;15708.764368534481;6247.96876015617;6302;6331.68341582919;6333.904991425133;6549.934500654933;3490.7207423406576;3548.3226837060497;3554.3779838528153;3567.714582833367;3691.8892433227047;2611.2688447234805;2662.7204143565036;2670.305720512642;2670.7863370930277;2672.1048448769493;445.9264221403432;477.05781082362057;484.326785767776;486.20262769058064;486.26331108370846;492.1436700141799;503.92189210672404;573.435166361134;577.742904407543;624.3600309682521;7086.716531338792;7494.362979146834;7564.810879728051;7579.54522728638;7657.57883316423;582.0977484898391;598.308953159102;606.3936063936064;610.3835126522245;612.1582823617526;3555.911102222465;3620.501635768822;3667.431548110047;3695.3533131701843;3728.086618778417;52697.20954185614;53301.200481992804;53550.19674704882;53561.73219133957;53638.73180634072;45776.54223457723;46107;46116.53883461189;47168;47174;40764.38853417201;41807.1638567227;42139.57860421418;42188.36717449241;42215;7524.435667324863;7548.320651141424;7640.8471830564185;7728.497647652885;7819.375028029568;31526.527102093027;31905.361892762478;32255.35489290154;32279.193020174684;32849.178770530925;36991.260174796895;37223.81388093042;38363.23273534569;40371.1925761489;40485.79757101196;8920;9090.772730681785;9285.117913798178;9317.44095354281;9398.906010940076;10277.691669249934;10278.691639250834;10303.321136504414;10357.63748268807;10527.210459215436;9419.246460283299;9707.271954603291;9771.413715177112;9844.261680373857;9987.25095617817;9347;9412.15290623847;9500.809983800147;9564.4739539326;9634.9036509634;9351.158395744416;9362.95318523403;9394.906050939404;9479.194268487256;9550.140487356171;8193.918060819315;8551.828963420821;8552.786180345542;8566.914157499052;8660.870086948828;8004.719834805754;8115.594220288844;8189.959050204711;8300.128486509071;8373.665053397795 11:39:16 INFO - 2015-12-09 11:39:16,590 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:39:16 INFO - 2015-12-09 11:39:16,590 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,926 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: __startTimestamp1449689956582__endTimestamp 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: Number of tests: 6 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4659.38 Median:4746.38 stddev:493.75 (10.4%) stddev-sans-first:469.18 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: Values: 2640.5 2748.7 2749.7 2754.6 2779.6 4330.5 4497.1 4735.5 4773.6 4795.5 4594.2 4645.3 4682.8 4687.9 4739.3 4168.2 4317.1 4317.1 4388.8 4407.3 4382.3 4444.2 4445.7 4446.5 4480.7 4185.7 4236.3 4303.4 4350.8 4355.7 4332.6 4377.8 4379.4 4382.0 4413.8 4361.9 4364.8 4367.2 4380.6 4394.8 4424.9 4507.5 4525.6 4592.2 4734.6 5137.4 5156.5 5157.3 5158.1 5164.3 5176.4 5180.8 5184.6 5214.4 5234.8 4434.5 4542.4 4546.5 4665.8 4762.4 5198.3 5256.4 5267.9 5268.8 5270.8 5021.3 5035.7 5046.4 5049.4 5087.5 4865.2 4962.5 4964.7 4970.5 5113.7 5031.1 5033.3 5036.7 5038.5 5071.3 5059.2 5059.5 5066.1 5066.8 5122.6 4032.0 4120.7 4193.9 4206.3 4296.9 3651.1 3671.3 3698.8 3704.9 3739.4 4372.4 4373.4 4378.2 4387.7 4414.0 4824.1 4927.9 4938.8 4998.4 5139.3 4324.4 4329.9 4330.2 4336.8 4345.0 4499.0 4507.8 4510.5 4518.9 4548.1 4584.2 4719.5 4736.5 4736.6 4814.2 5086.5 5101.9 5106.7 5108.5 5116.5 4824.9 4830.5 4832.1 4839.2 4868.9 4746.4 4852.2 4856.0 4954.2 5078.4 5094.0 5100.5 5113.2 5120.7 5126.8 4933.3 4936.8 4936.8 4942.1 4987.6 4666.1 4718.1 4764.6 4768.0 4918.3 4850.1 4864.1 4870.1 4874.7 4904.5 4980.6 4988.1 4988.3 4993.1 5006.5 4611.7 4720.1 4720.6 4724.1 4855.0 11:39:16 INFO - 2015-12-09 11:39:16,591 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,592 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41883.67 Median:161564.21 stddev:67277.23 (41.6%) stddev-sans-first:67394.28 11:39:16 INFO - 2015-12-09 11:39:16,593 DEBUG : BROWSER_OUTPUT: Values: 520.9 530.3 531.9 545.9 547.4 27109.3 28358.7 36841.4 37642.6 37692.6 42398.8 42489.8 42748.1 42885.0 43041.0 7096.7 7973.6 8158.9 8161.6 8183.4 7218.1 10211.1 10505.5 10514.5 10514.5 10234.2 10323.6 10330.9 10337.5 10347.3 7225.6 7487.5 10058.2 10223.5 10347.3 10054.4 10212.0 10215.3 10220.6 10228.4 38681.8 39250.0 39269.0 39299.0 39318.6 2915.3 2919.5 2923.8 2954.6 2961.5 28626.9 28957.9 29160.9 29182.0 29452.3 3325.7 3339.1 3368.4 3370.5 3461.5 217528.0 218761.0 218798.0 218948.0 219784.0 53052.2 54738.5 58082.7 58554.7 62540.4 56470.4 56531.0 56683.7 56732.9 56743.0 14988.4 15338.9 15351.5 15352.1 15361.5 11479.8 11667.8 11683.2 11683.7 11689.2 19273.2 19542.3 19684.7 19728.8 19826.3 7444.4 7552.6 7625.5 7642.8 7672.2 860.1 916.6 1010.4 1016.8 1083.0 27196.0 27474.9 27486.7 27551.0 27728.4 935.9 992.3 992.6 1001.9 1047.2 13126.2 13447.0 13482.2 13507.3 13575.9 287028.0 292338.0 293179.0 293283.0 293795.0 47336.0 47584.0 47594.8 47667.5 47704.3 1223.6 1229.4 1229.9 1233.8 1241.9 24542.5 24784.5 24934.5 25168.1 25185.9 38790.0 39110.6 39142.9 39214.0 39244.2 256410.0 257282.0 258953.0 259641.0 260016.0 26428.3 26867.9 28269.4 29286.6 29544.9 37218.3 37290.3 37409.6 38043.2 38074.2 32208.5 32466.8 32956.2 33623.5 33761.3 27750.6 30034.2 32202.5 32693.3 32935.8 31441.8 33024.0 33039.5 33656.2 33756.0 29333.4 29686.4 30025.0 30176.8 30217.7 23170.7 23262.3 23536.6 23771.2 23835.3 11:39:16 INFO - 2015-12-09 11:39:16,593 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,593 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27433.13 Median:39397.81 stddev:84397.55 (214.2%) stddev-sans-first:84609.66 11:39:16 INFO - 2015-12-09 11:39:16,594 DEBUG : BROWSER_OUTPUT: Values: 269.7 271.4 271.5 276.1 276.6 10529.0 15156.2 15531.2 15565.5 17053.2 16205.9 16332.3 16510.8 16514.0 16759.3 5414.5 5548.9 5563.8 5569.1 5574.9 5513.8 5559.3 5559.8 5566.2 5567.2 4017.1 4133.6 5406.7 5531.9 6239.3 6281.8 6308.8 6315.0 6363.2 6365.6 5993.5 6085.5 6461.3 6467.6 6475.2 19614.1 19998.1 20393.7 20554.6 20583.3 1957.3 1985.7 2023.7 2042.1 2124.8 8308.8 8649.2 13159.7 13303.5 13910.0 1752.6 1756.0 1773.4 1783.3 1799.7 54801.2 56453.7 57181.9 57574.0 57901.1 9513.1 9549.5 9560.0 9573.4 9577.2 11954.3 11957.2 11964.9 11969.0 11970.3 6876.1 6893.0 7134.3 7161.6 7215.1 6848.5 7031.8 7044.7 7057.8 7122.7 3960.5 3963.0 3969.8 3975.8 4049.4 1630.8 1638.1 1642.9 1651.2 1672.7 695.4 782.1 796.7 814.6 914.2 14679.2 15324.5 15623.3 16286.0 16564.2 726.9 804.8 832.3 869.3 889.5 8087.0 8325.7 8599.7 9035.7 9267.9 512296.0 515313.0 515497.0 519405.0 522819.0 74033.3 75007.6 75323.6 76297.0 76359.6 1077.2 1086.9 1093.1 1094.9 1096.0 15160.3 15220.3 15250.5 15390.5 15477.9 30801.2 30871.0 32370.0 32455.2 34534.1 37336.3 37767.8 37823.6 39307.4 39488.2 8421.4 8556.5 8710.8 8943.2 8954.8 16248.7 16387.0 16570.2 16609.8 16938.8 10769.6 11171.8 13576.7 14447.1 14601.6 11643.5 13541.2 14018.3 14197.9 14493.1 14521.0 14612.7 14627.1 15018.8 15104.9 8781.6 8846.1 8919.7 8926.0 8950.1 9262.4 12759.7 14146.1 14311.4 14480.1 11:39:16 INFO - 2015-12-09 11:39:16,594 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,594 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4959.34 Median:6159.99 stddev:2585.77 (42.0%) stddev-sans-first:2579.43 11:39:16 INFO - 2015-12-09 11:39:16,596 DEBUG : BROWSER_OUTPUT: Values: 1431.5 1641.1 1688.6 1710.8 1711.7 5771.6 7080.6 7254.5 7256.6 7271.2 7089.2 7287.6 7293.8 7339.0 7340.3 1713.9 1738.4 1739.0 2008.8 2049.4 1999.5 2038.7 2050.1 2052.6 2055.4 1938.5 1953.0 1955.5 2011.1 2013.2 1971.7 1985.5 2007.8 2015.8 2017.0 2056.1 2083.8 2084.1 2085.6 2086.8 7130.7 7249.3 7256.1 7258.1 7265.7 4112.5 4138.8 4207.3 4209.6 4210.4 2701.0 2746.8 2759.7 2768.0 2783.7 806.2 845.1 850.9 851.7 880.0 9748.7 9752.5 9753.7 9758.2 9768.8 3737.8 3773.5 3851.6 3856.5 3858.1 8427.0 8432.3 8435.5 8438.5 8442.9 4249.7 4264.1 4273.7 4275.4 4287.7 3892.6 3904.4 3908.2 3912.0 3919.5 2867.0 2907.5 3094.1 3362.7 3464.8 1031.9 1040.8 1041.2 1043.0 1043.4 899.2 913.0 914.2 916.2 1174.2 6848.6 6973.3 6975.0 6980.3 6987.3 1044.3 1099.3 1122.4 1141.5 1151.6 5074.4 5398.7 5412.1 5413.4 5424.1 8125.6 8202.5 8318.5 8368.5 8386.5 8281.8 8340.4 8351.4 8390.8 8411.0 6575.7 6608.7 6672.5 6677.2 6680.2 6341.7 6557.1 6561.9 6575.2 6575.8 7321.4 7414.5 7574.7 7684.8 7689.4 7654.3 7855.6 7861.2 7864.7 7922.4 6107.2 6170.8 6195.2 6198.2 6201.7 5535.4 5631.7 6842.6 6936.0 6981.4 6490.4 6530.4 6568.3 6578.3 6621.4 6285.7 6339.4 6347.1 6467.1 6486.0 5898.9 6006.5 6011.5 6046.1 6068.0 6080.8 6138.3 6139.4 6142.8 6149.1 6137.7 6185.8 6214.3 6239.2 6269.0 11:39:16 INFO - 2015-12-09 11:39:16,596 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,596 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4582.05 Median:5294.11 stddev:1396.30 (26.4%) stddev-sans-first:1361.91 11:39:16 INFO - 2015-12-09 11:39:16,597 DEBUG : BROWSER_OUTPUT: Values: 254.5 257.9 258.3 259.4 261.5 5295.0 5326.5 5340.1 5345.1 5388.2 4849.7 4952.5 5141.2 5250.6 5272.4 4021.4 4023.7 4028.7 4036.4 4041.2 4027.4 4039.5 4043.6 4046.9 4052.8 3796.6 3868.1 3883.5 3912.9 3962.4 3955.4 3972.8 3987.4 3997.8 4000.5 3448.1 3455.6 3457.0 3459.8 3462.5 5111.8 5113.1 5114.6 5118.2 5118.7 4481.3 4551.1 4566.1 4572.3 4572.9 5528.9 5536.4 5542.0 5542.8 5545.6 3748.3 3753.4 3753.8 3754.9 3756.0 5846.2 5846.7 5847.7 5853.1 5855.4 3716.2 3838.4 3861.5 3862.8 3862.9 3893.8 3908.7 3909.0 3909.8 3913.7 4538.0 4541.4 4547.4 4550.5 4553.8 5571.7 5573.7 5573.9 5575.5 5575.6 1349.2 1367.8 1367.9 1369.0 1369.8 903.2 905.7 929.0 934.6 940.3 4778.5 4810.0 4814.1 4816.2 4819.7 5738.6 5742.1 5744.4 5747.8 5750.1 4654.0 4759.5 4801.8 4809.9 4817.9 3019.9 3101.0 3109.1 3113.9 3123.4 5461.7 5482.1 5490.8 5499.1 5502.6 5990.4 5992.8 5993.9 5994.4 5999.2 5293.2 5483.2 5516.4 5521.9 5526.4 5838.1 5848.8 5854.8 5855.5 5856.0 5699.0 5702.4 5703.5 5710.4 5710.8 5336.4 5491.6 5509.8 5513.8 5521.4 3730.1 3755.9 3758.9 3760.8 3762.3 5826.1 5836.2 5847.4 5849.1 5856.9 5610.2 5624.7 5628.3 5637.3 5647.4 5409.3 5556.4 5617.6 5625.4 5634.1 5523.9 5524.1 5535.7 5537.7 5540.5 5675.9 5679.2 5681.2 5681.4 5690.5 5434.9 5506.4 5522.1 5551.4 5556.1 11:39:16 INFO - 2015-12-09 11:39:16,597 DEBUG : BROWSER_OUTPUT: 11:39:16 INFO - 2015-12-09 11:39:16,597 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12387.90 Median:590.20 stddev:14364.03 (2433.7%) stddev-sans-first:14377.28 11:39:16 INFO - 2015-12-09 11:39:16,598 DEBUG : BROWSER_OUTPUT: Values: 650.0 652.1 717.5 721.5 755.3 11655.5 14139.3 14292.7 14432.6 14439.8 13031.3 13494.3 13499.9 13512.1 13538.4 623.8 628.5 782.9 798.0 799.6 799.6 806.7 810.9 812.9 813.1 836.2 850.7 851.1 851.2 851.3 656.2 664.1 809.4 830.5 848.1 613.2 615.4 616.2 617.3 617.6 12362.9 12666.7 12676.6 12678.2 12691.7 10232.9 11650.0 11737.4 11830.6 11941.3 9752.9 9853.0 9863.6 9913.0 10017.2 3247.2 3268.2 3282.1 3306.1 3408.6 39670.6 41782.0 41812.0 41912.0 41981.2 9329.8 9526.1 9544.8 9559.1 9765.4 15495.5 15609.0 15681.8 15697.8 15708.8 6248.0 6302.0 6331.7 6333.9 6549.9 3490.7 3548.3 3554.4 3567.7 3691.9 2611.3 2662.7 2670.3 2670.8 2672.1 445.9 477.1 484.3 486.2 486.3 492.1 503.9 573.4 577.7 624.4 7086.7 7494.4 7564.8 7579.5 7657.6 582.1 598.3 606.4 610.4 612.2 3555.9 3620.5 3667.4 3695.4 3728.1 52697.2 53301.2 53550.2 53561.7 53638.7 45776.5 46107.0 46116.5 47168.0 47174.0 40764.4 41807.2 42139.6 42188.4 42215.0 7524.4 7548.3 7640.8 7728.5 7819.4 31526.5 31905.4 32255.4 32279.2 32849.2 36991.3 37223.8 38363.2 40371.2 40485.8 8920.0 9090.8 9285.1 9317.4 9398.9 10277.7 10278.7 10303.3 10357.6 10527.2 9419.2 9707.3 9771.4 9844.3 9987.3 9347.0 9412.2 9500.8 9564.5 9634.9 9351.2 9363.0 9394.9 9479.2 9550.1 8193.9 8551.8 8552.8 8566.9 8660.9 8004.7 8115.6 8190.0 8300.1 8373.7 11:39:16 INFO - 2015-12-09 11:39:16,598 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:39:16 INFO - 2015-12-09 11:39:16,598 DEBUG : BROWSER_OUTPUT: 11:39:17 INFO - 2015-12-09 11:39:17,301 INFO : Browser exited with error code: 0 11:39:17 INFO - 2015-12-09 11:39:17,322 INFO : Completed test dromaeo_css (00:18:37) 11:39:17 INFO - 2015-12-09 11:39:17,322 INFO : Starting test kraken 11:39:17 INFO - 2015-12-09 11:39:17,322 DEBUG : operating with platform_type : linux_ 11:39:17 INFO - 2015-12-09 11:39:17,323 INFO : Initialising browser for kraken test... 11:39:17 INFO - 2015-12-09 11:39:17,329 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKKiVk/profile http://localhost:57690/getInfo.html 11:39:21 INFO - 2015-12-09 11:39:21,592 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:39:21 INFO - 2015-12-09 11:39:21,592 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:39:21 INFO - 2015-12-09 11:39:21,592 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:39:21 INFO - 2015-12-09 11:39:21,592 DEBUG : BROWSER_OUTPUT: __metrics 11:39:21 INFO - 2015-12-09 11:39:21,673 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] 11:39:21 INFO - 2015-12-09 11:39:21,737 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:39:22 INFO - 2015-12-09 11:39:22,648 INFO : Browser initialized. 11:39:22 INFO - 2015-12-09 11:39:22,648 INFO : Running cycle 1/1 for kraken test... 11:39:22 INFO - 2015-12-09 11:39:22,648 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpUKKiVk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:39:34 INFO - 2015-12-09 11:39:34,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 142606336 11:39:34 INFO - 2015-12-09 11:39:34,736 DEBUG : BROWSER_OUTPUT: 11:39:37 INFO - 2015-12-09 11:39:37,331 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57690/tests/kraken/driver.html?testName=audio-beat-detection) 11:39:37 INFO - 2015-12-09 11:39:37,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 177598464 11:39:37 INFO - 2015-12-09 11:39:37,913 DEBUG : BROWSER_OUTPUT: 11:39:40 INFO - 2015-12-09 11:39:40,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57690/tests/kraken/driver.html?testName=audio-dft) 11:39:41 INFO - 2015-12-09 11:39:41,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 166400000 11:39:41 INFO - 2015-12-09 11:39:41,194 DEBUG : BROWSER_OUTPUT: 11:39:44 INFO - 2015-12-09 11:39:44,178 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57690/tests/kraken/driver.html?testName=audio-fft) 11:39:44 INFO - 2015-12-09 11:39:44,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 152690688 11:39:44 INFO - 2015-12-09 11:39:44,744 DEBUG : BROWSER_OUTPUT: 11:39:46 INFO - 2015-12-09 11:39:46,803 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57690/tests/kraken/driver.html?testName=audio-oscillator) 11:39:47 INFO - 2015-12-09 11:39:47,376 DEBUG : BROWSER_OUTPUT: RSS: Main: 156676096 11:39:47 INFO - 2015-12-09 11:39:47,376 DEBUG : BROWSER_OUTPUT: 11:39:49 INFO - 2015-12-09 11:39:49,589 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57690/tests/kraken/driver.html?testName=imaging-gaussian-blur) 11:39:50 INFO - 2015-12-09 11:39:50,172 DEBUG : BROWSER_OUTPUT: RSS: Main: 157966336 11:39:50 INFO - 2015-12-09 11:39:50,172 DEBUG : BROWSER_OUTPUT: 11:39:53 INFO - 2015-12-09 11:39:53,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57690/tests/kraken/driver.html?testName=imaging-darkroom) 11:39:53 INFO - 2015-12-09 11:39:53,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 157327360 11:39:53 INFO - 2015-12-09 11:39:53,714 DEBUG : BROWSER_OUTPUT: 11:39:57 INFO - 2015-12-09 11:39:57,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57690/tests/kraken/driver.html?testName=imaging-desaturate) 11:39:57 INFO - 2015-12-09 11:39:57,683 DEBUG : BROWSER_OUTPUT: RSS: Main: 159232000 11:39:57 INFO - 2015-12-09 11:39:57,683 DEBUG : BROWSER_OUTPUT: 11:40:00 INFO - 2015-12-09 11:40:00,526 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57690/tests/kraken/driver.html?testName=json-parse-financial) 11:40:01 INFO - 2015-12-09 11:40:01,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 159678464 11:40:01 INFO - 2015-12-09 11:40:01,107 DEBUG : BROWSER_OUTPUT: 11:40:02 INFO - 2015-12-09 11:40:02,917 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57690/tests/kraken/driver.html?testName=json-stringify-tinderbox) 11:40:03 INFO - 2015-12-09 11:40:03,478 DEBUG : BROWSER_OUTPUT: RSS: Main: 167043072 11:40:03 INFO - 2015-12-09 11:40:03,478 DEBUG : BROWSER_OUTPUT: 11:40:05 INFO - 2015-12-09 11:40:05,349 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-aes) 11:40:05 INFO - 2015-12-09 11:40:05,951 DEBUG : BROWSER_OUTPUT: RSS: Main: 167567360 11:40:05 INFO - 2015-12-09 11:40:05,951 DEBUG : BROWSER_OUTPUT: 11:40:08 INFO - 2015-12-09 11:40:08,072 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-ccm) 11:40:08 INFO - 2015-12-09 11:40:08,653 DEBUG : BROWSER_OUTPUT: RSS: Main: 178962432 11:40:08 INFO - 2015-12-09 11:40:08,653 DEBUG : BROWSER_OUTPUT: 11:40:11 INFO - 2015-12-09 11:40:11,175 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 11:40:11 INFO - 2015-12-09 11:40:11,764 DEBUG : BROWSER_OUTPUT: RSS: Main: 183070720 11:40:11 INFO - 2015-12-09 11:40:11,764 DEBUG : BROWSER_OUTPUT: 11:40:14 INFO - 2015-12-09 11:40:14,358 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 11:40:14 INFO - 2015-12-09 11:40:14,931 DEBUG : BROWSER_OUTPUT: RSS: Main: 181678080 11:40:14 INFO - 2015-12-09 11:40:14,931 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,688 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57690/tests/kraken/driver.html?testName=ai-astar) 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: RSS: Main: 239681536 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;115;108;113;112;113;103;113;113;105 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;129;149;169;139;160;148;129;171;132 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;162;161;161;162;161;161;161;162;162 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;87;92;72;73;71;97;92;72 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;128;95;94;96;138;94;96;125 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;109;109;110;110;109;109;109;109 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;146;146;146;146;146;146;147;146;146 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;95;95;95;95;95 11:40:16 INFO - 2015-12-09 11:40:16,947 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;72;74;73;72;72;74;83;72;71 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;69;69;69;68;68;69 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;84;85;85;84;83;83;84;84 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;118;127;126;149;119;127;120;124;122;120 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;135;143;148;148;160;139;137;147;147;135 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;70;68;69;71;73;69;70;70 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: __start_cc_report 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1004 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: __end_cc_report 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: __startTimestamp1449690016942__endTimestamp 11:40:16 INFO - 2015-12-09 11:40:16,948 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: Number of tests: 14 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:3.97 (3.5%) stddev-sans-first:4.19 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: Values: 112.0 115.0 108.0 113.0 112.0 113.0 103.0 113.0 113.0 105.0 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.00 Median:151.50 stddev:15.67 (10.3%) stddev-sans-first:16.47 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: Values: 154.0 129.0 149.0 169.0 139.0 160.0 148.0 129.0 171.0 132.0 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.50 stddev:0.67 (0.4%) stddev-sans-first:0.53 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: Values: 160.0 162.0 161.0 161.0 162.0 161.0 161.0 161.0 162.0 162.0 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,949 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:80.00 stddev:10.52 (13.2%) stddev-sans-first:10.75 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 87.0 92.0 72.0 73.0 71.0 97.0 92.0 72.0 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.70 Median:95.00 stddev:17.31 (18.2%) stddev-sans-first:18.01 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 128.0 95.0 94.0 96.0 138.0 94.0 96.0 125.0 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.20 Median:109.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 109.0 109.0 110.0 110.0 109.0 109.0 109.0 109.0 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.20 Median:146.00 stddev:0.42 (0.3%) stddev-sans-first:0.33 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: Values: 147.0 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 146.0 11:40:16 INFO - 2015-12-09 11:40:16,950 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.00 (0.0%) stddev-sans-first:0.00 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:73.60 Median:73.00 stddev:3.44 (4.7%) stddev-sans-first:3.64 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: Values: 73.0 72.0 74.0 73.0 72.0 72.0 74.0 83.0 72.0 71.0 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.50 Median:69.00 stddev:0.53 (0.8%) stddev-sans-first:0.53 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 69.0 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,951 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:84.00 stddev:0.82 (1.0%) stddev-sans-first:0.78 11:40:16 INFO - 2015-12-09 11:40:16,952 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 84.0 85.0 85.0 84.0 83.0 83.0 84.0 84.0 11:40:16 INFO - 2015-12-09 11:40:16,952 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.20 Median:125.00 stddev:9.00 (7.2%) stddev-sans-first:9.17 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 118.0 127.0 126.0 149.0 119.0 127.0 120.0 124.0 122.0 120.0 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.90 Median:147.00 stddev:7.77 (5.3%) stddev-sans-first:7.54 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 135.0 143.0 148.0 148.0 160.0 139.0 137.0 147.0 147.0 135.0 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.80 Median:70.00 stddev:1.40 (2.0%) stddev-sans-first:1.45 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 68.0 69.0 71.0 73.0 69.0 70.0 70.0 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:40:16 INFO - 2015-12-09 11:40:16,953 DEBUG : BROWSER_OUTPUT: 11:40:17 INFO - 2015-12-09 11:40:17,778 INFO : Browser exited with error code: 0 11:40:17 INFO - 2015-12-09 11:40:17,832 INFO : Completed test kraken (00:01:00) 11:40:17 INFO - 2015-12-09 11:40:17,833 INFO : Starting test v8_7 11:40:17 INFO - 2015-12-09 11:40:17,833 DEBUG : operating with platform_type : linux_ 11:40:17 INFO - 2015-12-09 11:40:17,833 INFO : Initialising browser for v8_7 test... 11:40:17 INFO - 2015-12-09 11:40:17,839 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4ULWs/profile http://localhost:57690/getInfo.html 11:40:21 INFO - 2015-12-09 11:40:21,881 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 11:40:21 INFO - 2015-12-09 11:40:21,881 DEBUG : BROWSER_OUTPUT: colorDepth:24 11:40:21 INFO - 2015-12-09 11:40:21,881 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 11:40:21 INFO - 2015-12-09 11:40:21,881 DEBUG : BROWSER_OUTPUT: __metrics 11:40:21 INFO - 2015-12-09 11:40:21,978 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] 11:40:22 INFO - 2015-12-09 11:40:22,054 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 11:40:23 INFO - 2015-12-09 11:40:23,208 INFO : Browser initialized. 11:40:23 INFO - 2015-12-09 11:40:23,209 INFO : Running cycle 1/1 for v8_7 test... 11:40:23 INFO - 2015-12-09 11:40:23,209 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpZ4ULWs/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 11:40:35 INFO - 2015-12-09 11:40:35,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 143302656 11:40:35 INFO - 2015-12-09 11:40:35,225 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,649 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57690/tests/v8_7/run.html (next: http://localhost:57690/tests/v8_7/run.html) 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 442216448 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: __start_tp_report 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 11:40:56 INFO - 2015-12-09 11:40:56,908 DEBUG : BROWSER_OUTPUT: |0;Richards;165.53550736633008 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.0860545524395 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |2;Encrypt;281.37310073157005 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5122.448979591837 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |6;Boyer;12035.714285714286 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |7;RegExp;27054.054054054053 11:40:56 INFO - 2015-12-09 11:40:56,909 DEBUG : BROWSER_OUTPUT: |8;Splay;597.0326409495549 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: __end_tp_report 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: __startTimestamp1449690056901__endTimestamp 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: Number of tests: 10 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.54 Median:165.54 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: Values: 165.5 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.09 Median:192.09 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: Values: 192.1 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:281.37 Median:281.37 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: Values: 281.4 11:40:56 INFO - 2015-12-09 11:40:56,910 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5122.45 Median:5122.45 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: Values: 5122.4 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: Values: 1980.2 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: Values: 791.8 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12035.71 Median:12035.71 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: Values: 12035.7 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27054.05 Median:27054.05 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: Values: 27054.1 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,911 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:597.03 Median:597.03 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: Values: 597.0 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: Values: 4840.6 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 11:40:56 INFO - 2015-12-09 11:40:56,912 DEBUG : BROWSER_OUTPUT: 11:40:57 INFO - 2015-12-09 11:40:57,837 INFO : Browser exited with error code: 0 11:40:57 INFO - 2015-12-09 11:40:57,854 INFO : Completed test v8_7 (00:00:40) 11:40:57 INFO - 2015-12-09 11:40:57,906 INFO : Completed test suite (00:20:17) 11:40:57 INFO - 2015-12-09 11:40:57,906 DEBUG : Working with test: dromaeo_css 11:40:57 INFO - 2015-12-09 11:40:57,906 DEBUG : Generating results file: dromaeo_css 11:40:57 INFO - 2015-12-09 11:40:57,907 DEBUG : Working with test: kraken 11:40:57 INFO - 2015-12-09 11:40:57,907 DEBUG : Generating results file: kraken 11:40:57 INFO - 2015-12-09 11:40:57,908 INFO : javascript benchmark 11:40:57 INFO - 2015-12-09 11:40:57,908 DEBUG : Working with test: v8_7 11:40:57 INFO - 2015-12-09 11:40:57,908 DEBUG : Generating results file: v8_7 11:40:57 INFO - 2015-12-09 11:40:57,908 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:40:58 INFO - 2015-12-09 11:40:58,039 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 11:40:58 INFO - 2015-12-09 11:40:58,039 DEBUG : process_Request line: dromaeo_css 6332.88 graph.html#tests=[[72,132,35]] 11:40:58 INFO - 2015-12-09 11:40:58,039 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:40:58 INFO - 2015-12-09 11:40:58,144 DEBUG : process_Request line: kraken 1521.20 graph.html#tests=[[232,132,35]] 11:40:58 INFO - 2015-12-09 11:40:58,144 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 11:40:58 INFO - 2015-12-09 11:40:58,263 DEBUG : process_Request line: v8_7 19788.52 graph.html#tests=[[230,132,35]] 11:40:58 INFO - 2015-12-09 11:40:58,264 INFO : javascript benchmark 11:40:58 INFO - 2015-12-09 11:40:58,268 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2640.4851054044457, 2748.738869807368, 2749.738774816394, 2754.600582915476, 2779.6386469758927, 4330.458692663417, 4497.055618320157, 4735.5264473552625, 4773.594244489218, 4795.496472870346, 4594.218982772928, 4645.256758918574, 4682.836100736475, 4687.882802929928, 4739.312799644058, 4168.166366726652, 4317.0934103838235, 4317.13657268546, 4388.802503887317, 4407.316865885793, 4382.298832186851, 4444.177827101997, 4445.666575006888, 4446.533114023029, 4480.731156130642, 4185.727927684721, 4236.301010333276, 4303.440552728157, 4350.782460876943, 4355.673324500675, 4332.610065094157, 4377.824887004516, 4379.430674012358, 4382.035952090535, 4413.845515406945, 4361.890952726176, 4364.803583838735, 4367.192069467159, 4380.60574548289, 4394.802233899482, 4424.889377765549, 4507.549245075499, 4525.570070843298, 4592.196365636034, 4734.644901632391, 5137.38351397831, 5156.458571849939, 5157.252198431206, 5158.148905430637, 5164.2770012198325, 5176.430592634807, 5180.844574662766, 5184.559312458446, 5214.426413094557, 5234.842954711365, 4434.534373890728, 4542.432195975503, 4546.499885012646, 4665.790039448233, 4762.357081793983, 5198.2722418861385, 5256.448072952285, 5267.868303292372, 5268.841934741964, 5270.7628156733035, 5021.322121513622, 5035.748212589356, 5046.369203849519, 5049.368828896388, 5087.465816089331, 4865.197242454955, 4962.478939711351, 4964.67729597575, 4970.478099799541, 5113.718745469035, 5031.119554078022, 5033.3205017322925, 5036.748162591855, 5038.546530812245, 5071.340725705709, 5059.19052951526, 5059.544640982329, 5066.113430149709, 5066.797328106908, 5122.590192784568, 4031.992331426154, 4120.670346372283, 4193.874183774492, 4206.326987681956, 4296.914061718748, 3651.1419816343137, 3671.320805650963, 3698.7595806272507, 3704.9259014819554, 3739.439084137401, 4372.431583894074, 4373.365861949999, 4378.2119218540965, 4387.692861499664, 4414.0, 4824.0834241494, 4927.901441971212, 4938.802447902115, 4998.4251811042195, 5139.280500729901, 4324.437823083042, 4329.913401732011, 4330.242207613655, 4336.804843782037, 4344.9565504344555, 4498.955010449854, 4507.797149128297, 4510.526394728572, 4518.909621807611, 4548.135854187693, 4584.174848527297, 4719.504452032487, 4736.455307639666, 4736.597389221817, 4814.20565606671, 5086.54221120101, 5101.92347114801, 5106.719130447861, 5108.463611320758, 5116.4627714090975, 4824.903501930012, 4830.541098595628, 4832.130216561053, 4839.225723884161, 4868.902621947612, 4746.38297021385, 4852.1508735971765, 4855.975720121377, 4954.1825598775795, 5078.441371449211, 5093.955739073555, 5100.464451232567, 5113.15632920564, 5120.667156634807, 5126.79492820283, 4933.284673722218, 4936.753162341796, 4936.827211047596, 4942.135126352946, 4987.625928055338, 4666.11343844682, 4718.127146477913, 4764.618830493621, 4767.976160119178, 4918.336024636628, 4850.078485087822, 4864.075825593126, 4870.050340183772, 4874.658773885936, 4904.485029071896, 4980.626453016111, 4988.077205716954, 4988.301637770787, 4993.101241776515, 5006.549410553068, 4611.723296602215, 4720.079584480994, 4720.645951553716, 4724.078804633064, 4854.9514504855915], "unit": "ms", "name": "dojo.html", "value": 4628.837416520289}, {"lowerIsBetter": false, "replicates": [520.9192575150852, 530.2655821686963, 531.9228711836784, 545.9372172200195, 547.384192783119, 27109.322266943313, 28358.716412835867, 36841.44737828931, 37642.62357376426, 37692.62307376925, 42398.78800606, 42489.787551062276, 42748.14503709924, 42885.0, 43041.0, 7096.6806493707645, 7973.561454120036, 8158.877616835753, 8161.5919204039565, 8183.386246031541, 7218.133823941108, 10211.081002709754, 10505.474726263694, 10514.474276286155, 10514.474276286193, 10234.23243256755, 10323.638672646459, 10330.89669103307, 10337.483125843715, 10347.275690701654, 7225.5664660120565, 7487.475876688634, 10058.195344372432, 10223.48882555873, 10347.327423717434, 10054.396736195778, 10212.0, 10215.336003159771, 10220.591176352937, 10228.38629682214, 38681.806590966866, 39250.0, 39269.0, 39299.0, 39318.60681393178, 2915.2566095645475, 2919.474494590973, 2923.751481124107, 2954.5863579098946, 2961.526155815081, 28626.856865715745, 28957.85521072402, 29160.854195729098, 29182.0, 29452.26369340762, 3325.6840600142946, 3339.131825725329, 3368.360011597789, 3370.4607262837826, 3461.4807778833124, 217528.0, 218761.0, 218798.0, 218948.0, 219784.0, 53052.20421693678, 54738.45261547413, 58082.70958645264, 58554.70722646359, 62540.37459625345, 56470.43529564734, 56531.0, 56683.716581416826, 56732.865342692916, 56743.0, 14988.40046398132, 15338.923305383401, 15351.462698805488, 15352.078875267296, 15361.46234881796, 11479.770404592029, 11667.766644667228, 11683.182177247681, 11683.707907302385, 11689.181757276909, 19273.22907083729, 19542.31601893927, 19684.70472942907, 19728.802711972985, 19826.306079287155, 7444.367228785614, 7552.622368881534, 7625.542467451971, 7642.815363618648, 7672.232776722395, 860.1183786618766, 916.6470908700065, 1010.3988127064385, 1016.8118898003893, 1082.9783404332027, 27196.0, 27474.862625686743, 27486.725132748816, 27551.0, 27728.445431091266, 935.9204467620192, 992.3103443106971, 992.5731935267904, 1001.8697569316088, 1047.177965297238, 13126.212427254204, 13447.0, 13482.191068535723, 13507.257100859548, 13575.932120339336, 287028.0, 292338.0, 293179.0, 293283.0, 293795.0, 47336.0, 47584.0, 47594.762026189645, 47667.523324766305, 47704.28443573349, 1223.590097317391, 1229.4098832560242, 1229.8647148813623, 1233.771752225859, 1241.8571864235728, 24542.509149817262, 24784.50430991406, 24934.50130997406, 25168.119115830857, 25185.874070630263, 38790.0, 39110.6088939107, 39142.93284540901, 39214.0, 39244.2151156981, 256410.0, 257282.0, 258953.0, 259641.0, 260016.0, 26428.339291517095, 26867.86566067157, 28269.434611307246, 29286.560701589067, 29544.852275739344, 37218.25563488769, 37290.254194915404, 37409.625903741704, 38043.23913521769, 38074.23851523009, 32208.516872247405, 32466.83766581152, 32956.1760955978, 33623.48694308811, 33761.324773503904, 27750.5837412443, 30034.24914377158, 32202.516962245118, 32693.34613307768, 32935.835320823244, 31441.8427907859, 33024.0, 33039.50440743439, 33656.1585960353, 33756.0, 29333.41333173282, 29686.406271874872, 30025.0, 30176.84911575428, 30217.69782302237, 23170.652440213747, 23262.3021309361, 23536.6469502961, 23771.1680091196, 23835.284941451784], "unit": "ms", "name": "ext.html", "value": 17412.4175048282}, {"lowerIsBetter": false, "replicates": [269.6615747237217, 271.4232256455033, 271.5438064052392, 276.1164274322169, 276.6003125483677, 10529.029496458868, 15156.242187890603, 15531.223438828041, 15565.455209067684, 17053.232604532794, 16205.91897040516, 16332.34670613174, 16510.752338714898, 16514.0, 16759.329626814942, 5414.539764120044, 5548.86127846803, 5563.777448902059, 5569.081101618228, 5574.944250557503, 5513.8345849624575, 5559.3328800543995, 5559.77760889566, 5566.2207290979095, 5567.248421463111, 4017.076072503326, 4133.627973482386, 5406.729663516828, 5531.917021244684, 6239.313675495692, 6281.780137695182, 6308.842278943063, 6315.021171718391, 6363.204599425072, 6365.554411191241, 5993.482737250365, 6085.4523092921845, 6461.321561236096, 6467.579607325509, 6475.222973243194, 19614.117364718622, 19998.100085496186, 20393.694094588594, 20554.58890822175, 20583.279585214594, 1957.3247229705728, 1985.682290833474, 2023.6660950943076, 2042.1218875883364, 2124.8406369522195, 8308.833823323499, 8649.178328058888, 13159.736805263841, 13303.467861285537, 13910.0, 1752.5793809485758, 1756.0341812003346, 1773.4147731248786, 1783.3312507809571, 1799.7390378395191, 54801.1779823303, 56453.71773141108, 57181.85226846644, 57573.99999999958, 57901.05187377542, 9513.143817056498, 9549.474778887088, 9560.0, 9573.425594464354, 9577.23382129428, 11954.342511161969, 11957.162998590189, 11964.940175299242, 11969.0, 11970.281783093042, 6876.071730316443, 6893.034975103489, 7134.32223938725, 7161.606111663804, 7215.06204193462, 6848.520603557703, 7031.824204394931, 7044.718211271492, 7057.788266352018, 7122.679479423438, 3960.5445373782386, 3963.02905788078, 3969.801509924492, 3975.7813320267082, 4049.3521036633997, 1630.8450697183748, 1638.1399765123406, 1642.91785410729, 1651.1661610886426, 1672.7072762266555, 695.3950063444735, 782.1474592693877, 796.7330944133664, 814.5560669435172, 914.1681070226063, 14679.19264440466, 15324.463643772637, 15623.296951637203, 16286.0, 16564.171791410383, 726.9273072692688, 804.8028233082932, 832.2967092806568, 869.3219288954499, 889.5063239901916, 8087.0295564532635, 8325.708600198965, 8599.699010534601, 9035.728928132166, 9267.860982085274, 512296.0, 515313.0, 515497.0, 519405.0, 522819.0, 74033.25966740264, 75007.62496187484, 75323.62338188384, 76297.0, 76359.61820190975, 1077.186724023373, 1086.8858769829212, 1093.1309608861134, 1094.895984881435, 1096.0190629386655, 15160.31778569989, 15220.315085821387, 15250.542483725507, 15390.461333853262, 15477.922610386877, 30801.229969250053, 30871.0, 32370.0, 32455.188620284684, 34534.13664658403, 37336.25327493489, 37767.81116094402, 37823.621763783114, 39307.410388843615, 39488.2102357957, 8421.368397370345, 8556.529390883312, 8710.82578348442, 8943.23982461472, 8954.820903582022, 16248.700103991416, 16387.0, 16570.171491425623, 16609.833901661314, 16938.83061169422, 10769.569217231223, 11171.776564468502, 13576.660583485096, 14447.133172009713, 14601.561953141423, 11643.53425862956, 13541.187528748307, 14018.336516061916, 14197.858021420067, 14493.130412175304, 14520.983531152719, 14612.707745845237, 14627.122372657675, 15018.849811502183, 15104.924475377553, 8781.648734050566, 8846.115388461103, 8919.73240802777, 8926.0, 8950.104989500998, 9262.44425334482, 12759.744805104032, 14146.080504767157, 14311.427542898167, 14480.131192128507], "unit": "ms", "name": "jquery.html", "value": 8443.932563026216}, {"lowerIsBetter": false, "replicates": [1431.4775107085916, 1641.0891954964998, 1688.5609741467222, 1710.8460238578525, 1711.6833385823616, 5771.624844385117, 7080.610566418852, 7254.455915806322, 7256.6371681415985, 7271.200167981525, 7089.22018577956, 7287.562746235217, 7293.781186564412, 7339.009233753442, 7340.339369456748, 1713.8800283980127, 1738.400251913088, 1739.0, 2008.7890771468967, 2049.415916463808, 1999.4601457606439, 2038.7247721557549, 2050.0877109686194, 2052.5586998795256, 2055.424481145282, 1938.4959910423322, 1952.9804701953012, 1955.4720225539095, 2011.054804242004, 2013.1745984146503, 1971.7338159348592, 1985.4837742186992, 2007.7791442941266, 2015.8185763281301, 2017.0217444539387, 2056.074766355146, 2083.7707852136255, 2084.062172022596, 2085.572457646179, 2086.822620077295, 7130.679119439637, 7249.311315425026, 7256.129264488242, 7258.056452661173, 7265.673044712948, 4112.547619761824, 4138.793060347, 4207.284761590537, 4209.6421804146685, 4210.442136409548, 2700.972990270092, 2746.8489233092173, 2759.7378249066305, 2768.045024466556, 2783.6520434945633, 806.2219957740749, 845.1168528887266, 850.9149085091503, 851.6635928808148, 879.9736007919709, 9748.658796942073, 9752.4636145012, 9753.707388778277, 9758.219342452587, 9768.755781105529, 3737.7757334560015, 3773.547174339042, 3851.5763266040713, 3856.46009558662, 3858.093348063203, 8427.0, 8432.283255923192, 8435.536045517556, 8438.493690378597, 8442.873356899652, 4249.68127390447, 4264.061906380592, 4273.7008409411665, 4275.3800698898485, 4287.742735435884, 3892.552356479041, 3904.4338570907626, 3908.1988192420486, 3912.0415498203124, 3919.510061242345, 2867.0, 2907.4911890419094, 3094.1181763197383, 3362.65493802481, 3464.8440820163155, 1031.8813336466253, 1040.765827688764, 1041.2294901772784, 1042.9895701043044, 1043.4052590023766, 899.2221728205055, 912.9726108216764, 914.1863741270275, 916.2349438219028, 1174.236746115015, 6848.623325717133, 6973.302669732986, 6974.965125174342, 6980.336867997532, 6987.301269872972, 1044.2951008069522, 1099.3349023840622, 1122.3770807201918, 1141.4749215360862, 1151.585429245471, 5074.3657042869645, 5398.676079435168, 5412.052890744104, 5413.431589683105, 5424.05079111154, 8125.593720313961, 8202.507849528927, 8318.45930014547, 8368.456050356708, 8386.538740369338, 8281.751547453587, 8340.37447191463, 8351.3736469765, 8390.832183356299, 8410.957945210235, 6575.671216439159, 6608.669566521655, 6672.499562532829, 6677.198736151596, 6680.198376194888, 6341.682915854097, 6557.147570815763, 6561.934380656323, 6575.24384695747, 6575.835604109936, 7321.414286856932, 7414.480986330905, 7574.659140338587, 7684.769456916301, 7689.423293252917, 7654.272844079804, 7855.567943763148, 7861.213878612093, 7864.72473463426, 7922.366210703245, 6107.175531303217, 6170.845728856814, 6195.16365290698, 6198.163247961467, 6201.689915504297, 5535.363433205233, 5631.746571404378, 6842.55523390978, 6936.028955946071, 6981.406580440719, 6490.383413575702, 6530.379613936669, 6568.310327415553, 6578.276389597045, 6621.370969757865, 6285.717142728497, 6339.397757213057, 6347.111404403479, 6467.094606754964, 6486.027095935648, 5898.94101058984, 6006.459418652167, 6011.458968692838, 6046.123312119806, 6068.029115341524, 6080.847978800389, 6138.324784273816, 6139.447449729546, 6142.78500252489, 6149.139120523219, 6137.723802428812, 6185.84535386619, 6214.25428948529, 6239.188905442264, 6269.028300613412], "unit": "ms", "name": "mootools.html", "value": 4061.632832599809}, {"lowerIsBetter": false, "replicates": [254.53801350548756, 257.85946659070805, 258.3373646596481, 259.4266670657846, 261.50314402635, 5295.0468915595175, 5326.520613144816, 5340.145576707722, 5345.091334473139, 5388.191771234317, 4849.660523763338, 4952.529509696573, 5141.15170996786, 5250.632455728091, 5272.446393128724, 4021.3967904814367, 4023.6579890709327, 4028.6777057835448, 4036.3945408188715, 4041.1917616476676, 4027.3556231003045, 4039.4546736190678, 4043.595640435962, 4046.858359957402, 4052.8378864845517, 3796.6393192646656, 3868.071662800936, 3883.456316115746, 3912.941305880414, 3962.405639154121, 3955.3671412573995, 3972.841086356557, 3987.3819557968563, 3997.780122093284, 4000.4799376080923, 3448.1207292140343, 3455.6198818129988, 3457.0320310313155, 3459.844307006191, 3462.480627905809, 5111.795528178905, 5113.105206588869, 5114.590832733373, 5118.206677964921, 5118.667286626357, 4481.260592002316, 4551.112533056055, 4566.06395688883, 4572.337011133401, 4572.862814115582, 5528.861778455531, 5536.390996990328, 5542.0, 5542.75057622408, 5545.639533430314, 3748.3440397930253, 3753.380692185786, 3753.7935413552245, 3754.906127346811, 3756.0, 5846.152307915371, 5846.678432686201, 5847.736851841677, 5853.1220316952795, 5855.385184555603, 3716.1824398632257, 3838.4242363645676, 3861.4593956846065, 3862.806859657062, 3862.9227415452096, 3893.844246230176, 3908.7263891527887, 3909.0422846402244, 3909.843606255775, 3913.726039177287, 4538.001639639274, 4541.364209010675, 4547.431571053618, 4550.453945526558, 4553.840615578439, 5571.693556854331, 5573.721313934287, 5573.916391254134, 5575.470330318613, 5575.553955683536, 1349.1500354776429, 1367.7606418876658, 1367.856375080622, 1369.0074695845433, 1369.8493165751759, 903.2277402820494, 905.7011186308634, 928.9535523223811, 934.5934518484481, 940.3088729783603, 4778.4982576829625, 4810.037992401533, 4814.109389762905, 4816.20532612122, 4819.6867203631655, 5738.626989245686, 5742.138679198154, 5744.425557444222, 5747.798827041033, 5750.079987202112, 4653.976730116327, 4759.547842954914, 4801.831935882297, 4809.879753006203, 4817.855464336076, 3019.89430369936, 3100.9844950775555, 3109.0517392195147, 3113.8910138145056, 3123.359711259232, 5461.699606521679, 5482.068048431776, 5490.780368785284, 5499.065158922913, 5502.642328248651, 5990.400959903975, 5992.820215393545, 5993.910091348634, 5994.400559943971, 5999.190109335271, 5293.179557168645, 5483.150111732688, 5516.365617953907, 5521.861953451196, 5526.447355264441, 5838.12428135783, 5848.766049357978, 5854.765809367577, 5855.502282305882, 5856.004479238454, 5699.0311647020935, 5702.429757024264, 5703.515201207778, 5710.428957104256, 5710.828675139753, 5336.412994570672, 5491.615586908878, 5509.807156749494, 5513.751881165277, 5521.420250873761, 3730.0674831292176, 3755.943660845144, 3758.8684396046006, 3760.7743535387963, 3762.266358060152, 5826.067829147316, 5836.182934389104, 5847.44449277318, 5849.093390524476, 5856.853578660397, 5610.242617246783, 5624.74688639004, 5628.324601047901, 5637.295338082739, 5647.407022262603, 5409.323109835964, 5556.444355564411, 5617.634853734494, 5625.381208067028, 5634.070378387521, 5523.861903452285, 5524.088525393265, 5535.723213839211, 5537.6954267515675, 5540.501354878081, 5675.858103547279, 5679.233303503974, 5681.204631351697, 5681.375048744552, 5690.544756419559, 5434.864128396822, 5506.394296627288, 5522.144067669517, 5551.417101204315, 5556.138798486241], "unit": "ms", "name": "prototype.html", "value": 4116.2042213999}, {"lowerIsBetter": false, "replicates": [649.9675016249192, 652.1489456259583, 717.4905816870022, 721.5382155420535, 755.3466251692286, 11655.533778648844, 14139.29303534823, 14292.713655770978, 14432.5670229893, 14439.783403248934, 13031.283279419627, 13494.25781582015, 13499.932500337485, 13512.05415620907, 13538.39077241524, 623.8284471770277, 628.4846425930739, 782.8903953446522, 798.0144521515923, 799.580220384297, 799.6401619271322, 806.7055524733489, 810.8702607582788, 812.8780682897553, 813.1299509524811, 836.2348451167175, 850.7447765670305, 851.1020872979004, 851.1701091435863, 851.2721623012328, 656.1764984943889, 664.139938779282, 809.4374409785202, 830.5307501261768, 848.1179573243819, 613.2181468627535, 615.4184295840432, 616.1927874484395, 617.3486971245335, 617.6448542088317, 12362.938185309016, 12666.746665066647, 12676.556320528738, 12678.239305641599, 12691.746165076647, 10232.89767102327, 11650.0, 11737.413129343584, 11830.645080647595, 11941.343226122559, 9752.90247097527, 9852.95073524635, 9863.60545578176, 9913.0, 10017.248706347053, 3247.220667039917, 3268.166617512543, 3282.097423208637, 3306.0908250231137, 3408.5739282589675, 39670.60329396698, 41782.0, 41812.0, 41911.95220119491, 41981.1603767926, 9329.766755831159, 9526.095020972996, 9544.761380965532, 9559.091886270793, 9765.414075155513, 15495.45765898188, 15609.0, 15681.764773528406, 15697.843021569866, 15708.764368534481, 6247.96876015617, 6302.0, 6331.68341582919, 6333.904991425133, 6549.934500654933, 3490.7207423406576, 3548.3226837060497, 3554.3779838528153, 3567.714582833367, 3691.8892433227047, 2611.2688447234805, 2662.7204143565036, 2670.305720512642, 2670.7863370930277, 2672.1048448769493, 445.9264221403432, 477.05781082362057, 484.326785767776, 486.20262769058064, 486.26331108370846, 492.1436700141799, 503.92189210672404, 573.435166361134, 577.742904407543, 624.3600309682521, 7086.716531338792, 7494.362979146834, 7564.810879728051, 7579.54522728638, 7657.57883316423, 582.0977484898391, 598.308953159102, 606.3936063936064, 610.3835126522245, 612.1582823617526, 3555.911102222465, 3620.501635768822, 3667.431548110047, 3695.3533131701843, 3728.086618778417, 52697.20954185614, 53301.200481992804, 53550.19674704882, 53561.73219133957, 53638.73180634072, 45776.54223457723, 46107.0, 46116.53883461189, 47168.0, 47174.0, 40764.38853417201, 41807.1638567227, 42139.57860421418, 42188.36717449241, 42215.0, 7524.435667324863, 7548.320651141424, 7640.8471830564185, 7728.497647652885, 7819.375028029568, 31526.527102093027, 31905.361892762478, 32255.35489290154, 32279.193020174684, 32849.178770530925, 36991.260174796895, 37223.81388093042, 38363.23273534569, 40371.1925761489, 40485.79757101196, 8920.0, 9090.772730681785, 9285.117913798178, 9317.44095354281, 9398.906010940076, 10277.691669249934, 10278.691639250834, 10303.321136504414, 10357.63748268807, 10527.210459215436, 9419.246460283299, 9707.271954603291, 9771.413715177112, 9844.261680373857, 9987.25095617817, 9347.0, 9412.15290623847, 9500.809983800147, 9564.4739539326, 9634.9036509634, 9351.158395744416, 9362.95318523403, 9394.906050939404, 9479.194268487256, 9550.140487356171, 8193.918060819315, 8551.828963420821, 8552.786180345542, 8566.914157499052, 8660.870086948828, 8004.719834805754, 8115.594220288844, 8189.959050204711, 8300.128486509071, 8373.665053397795], "unit": "ms", "name": "yui.html", "value": 5668.728834670197}], "name": "dromaeo_css", "value": 6332.8781147023665}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 115.0, 108.0, 113.0, 112.0, 113.0, 103.0, 113.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [154.0, 129.0, 149.0, 169.0, 139.0, 160.0, 148.0, 129.0, 171.0, 132.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.0}, {"lowerIsBetter": true, "replicates": [160.0, 162.0, 161.0, 161.0, 162.0, 161.0, 161.0, 161.0, 162.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 87.0, 92.0, 72.0, 73.0, 71.0, 97.0, 92.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 128.0, 95.0, 94.0, 96.0, 138.0, 94.0, 96.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 105.7}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.2}, {"lowerIsBetter": true, "replicates": [147.0, 146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [73.0, 72.0, 74.0, 73.0, 72.0, 72.0, 74.0, 83.0, 72.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 73.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.5}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 84.0, 85.0, 85.0, 84.0, 83.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [118.0, 127.0, 126.0, 149.0, 119.0, 127.0, 120.0, 124.0, 122.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.2}, {"lowerIsBetter": true, "replicates": [135.0, 143.0, 148.0, 148.0, 160.0, 139.0, 137.0, 147.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.9}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 68.0, 69.0, 71.0, 73.0, 69.0, 70.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.8}], "name": "kraken", "value": 1521.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.53550736633008], "unit": "score", "name": "Richards", "value": 213.25938200000004}, {"lowerIsBetter": false, "replicates": [192.0860545524395], "unit": "score", "name": "DeltaBlue", "value": 344.2103079999998}, {"lowerIsBetter": false, "replicates": [281.37310073157005], "unit": "score", "name": "Encrypt", "value": 946.0072739999998}, {"lowerIsBetter": false, "replicates": [5122.448979591837], "unit": "score", "name": "Decrypt", "value": 51.96362151394425}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12035.714285714286], "unit": "score", "name": "Boyer", "value": 55.37378041543021}, {"lowerIsBetter": false, "replicates": [27054.054054054053], "unit": "score", "name": "RegExp", "value": 33.67277222777225}, {"lowerIsBetter": false, "replicates": [597.0326409495549], "unit": "score", "name": "Splay", "value": 136.49337475149107}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19788.522454965994}]} 11:40:58 INFO - RETURN: dromaeo_css: 6332.88 11:40:58 INFO - RETURN: kraken: 1521.20 11:40:58 INFO - RETURN: v8_7: 19788.52 11:40:58 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19788.52"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1521.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6332.88"}}} 11:40:58 INFO - Return code: 0 11:40:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 11:40:58 INFO - # TBPL SUCCESS # 11:40:58 INFO - Running post-action listener: _resource_record_post_action 11:40:58 INFO - Running post-run listener: _resource_record_post_run 11:40:59 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 12288; Write bytes: 520687616; Read time: 216; Write time: 596180 11:40:59 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 243286016; Read time: 76; Write time: 369272 11:40:59 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 8192; Write bytes: 277401600; Read time: 140; Write time: 226908 11:40:59 INFO - Running post-run listener: _upload_blobber_files 11:40:59 INFO - Blob upload gear active. 11:40:59 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 11:40:59 INFO - Copying logs to upload dir... 11:40:59 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.597160 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-12-09 11:40:59.445659) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:40:59.448847) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010013 build_url: 'https://queue.taskcluster.net/v1/task/dG1acwOZStuVBk76Rkj_sw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-12-09 11:40:59.501022) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:40:59.501371) ========= 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-1449688595.233271-1160338425 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004566 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-12-09 11:40:59.551237) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:40:59.551609) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-12-09 11:40:59.551953) ========= ========= Total master_lag: 0.22 =========