builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-023 starttime: 1448309783.49 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.490624) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.491179) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.491506) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004481 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.507497) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.507821) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.517378) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.517836) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003956 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.566437) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.566762) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.567200) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.567545) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 12:16:25-- 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% 217M=0s 2015-11-23 12:16:25 (217 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.113820 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.693771) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.694133) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015404 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.744360) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:23.744745) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 489332006384610e3322739f66729448da0e98d9 --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 489332006384610e3322739f66729448da0e98d9 --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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 12:16:25,352 truncating revision to first 12 chars 2015-11-23 12:16:25,352 Setting DEBUG logging. 2015-11-23 12:16:25,352 attempt 1/10 2015-11-23 12:16:25,353 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:16:26,031 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=0.969527 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:24.726888) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:24.727213) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:24.735620) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:24.735894) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:24.736299) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-23 12:16:24.736593) ========= /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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:26 INFO - MultiFileLogger online at 20151123 12:16:26 in /builds/slave/test 12:16:26 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 12:16:26 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:26 INFO - {'append_to_log': False, 12:16:26 INFO - 'base_work_dir': '/builds/slave/test', 12:16:26 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:16:26 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:26 INFO - 'branch': 'Fx-Team-Non-PGO', 12:16:26 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:26 INFO - 'config_files': ('talos/linux_config.py',), 12:16:26 INFO - 'default_actions': ('clobber', 12:16:26 INFO - 'read-buildbot-config', 12:16:26 INFO - 'download-and-extract', 12:16:26 INFO - 'populate-webroot', 12:16:26 INFO - 'create-virtualenv', 12:16:26 INFO - 'install', 12:16:26 INFO - 'run-tests'), 12:16:26 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:26 INFO - 'download_minidump_stackwalk': True, 12:16:26 INFO - 'download_symbols': 'ondemand', 12:16:26 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:26 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:26 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:26 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:26 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:26 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:26 INFO - 'installer_path': 'installer.exe', 12:16:26 INFO - 'log_level': 'info', 12:16:26 INFO - 'log_name': 'talos', 12:16:26 INFO - 'log_to_console': True, 12:16:26 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:26 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:26 INFO - 'opt_config_files': (), 12:16:26 INFO - 'pip_index': False, 12:16:26 INFO - 'sps_profile': False, 12:16:26 INFO - 'sps_profile_interval': 0, 12:16:26 INFO - 'suite': 'dromaeojs', 12:16:26 INFO - 'system_bits': '64', 12:16:26 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:26 INFO - 'title': 'talos-linux64-ix-023', 12:16:26 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:26 INFO - 'use_talos_json': True, 12:16:26 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:26 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:26 INFO - 'work_dir': 'build'} 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running clobber step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: clobber 12:16:26 INFO - rmtree: /builds/slave/test/build 12:16:26 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:26 INFO - Running post-action listener: _resource_record_post_action 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running read-buildbot-config step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: read_buildbot_config 12:16:26 INFO - Using buildbot properties: 12:16:26 INFO - { 12:16:26 INFO - "properties": { 12:16:26 INFO - "buildnumber": 2109, 12:16:26 INFO - "product": "firefox", 12:16:26 INFO - "script_repo_revision": "production", 12:16:26 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:26 INFO - "repository": "", 12:16:26 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:16:26 INFO - "buildid": "20151121014332", 12:16:26 INFO - "slavename": "talos-linux64-ix-023", 12:16:26 INFO - "pgo_build": "False", 12:16:26 INFO - "basedir": "/builds/slave/test", 12:16:26 INFO - "project": "", 12:16:26 INFO - "platform": "ubuntu64_hw", 12:16:26 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:16:26 INFO - "slavebuilddir": "test", 12:16:26 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:16:26 INFO - "branch": "fx-team", 12:16:26 INFO - "repo_path": "integration/fx-team", 12:16:26 INFO - "stage_platform": "linux64", 12:16:26 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 12:16:26 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:26 INFO - }, 12:16:26 INFO - "sourcestamp": { 12:16:26 INFO - "repository": "", 12:16:26 INFO - "hasPatch": false, 12:16:26 INFO - "project": "", 12:16:26 INFO - "branch": "fx-team-linux64-talos", 12:16:26 INFO - "changes": [ 12:16:26 INFO - { 12:16:26 INFO - "category": null, 12:16:26 INFO - "files": [ 12:16:26 INFO - { 12:16:26 INFO - "url": null, 12:16:26 INFO - "name": "https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:16:26 INFO - } 12:16:26 INFO - ], 12:16:26 INFO - "repository": "", 12:16:26 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 12:16:26 INFO - "who": "dgottwald@mozilla.com", 12:16:26 INFO - "when": 1448100613, 12:16:26 INFO - "number": 6692170, 12:16:26 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 12:16:26 INFO - "project": "", 12:16:26 INFO - "at": "Sat 21 Nov 2015 02:10:13", 12:16:26 INFO - "branch": "fx-team-linux64-talos", 12:16:26 INFO - "revlink": "", 12:16:26 INFO - "properties": [ 12:16:26 INFO - [ 12:16:26 INFO - "buildid", 12:16:26 INFO - "20151121014332", 12:16:26 INFO - "Change" 12:16:26 INFO - ], 12:16:26 INFO - [ 12:16:26 INFO - "builduid", 12:16:26 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 12:16:26 INFO - "Change" 12:16:26 INFO - ], 12:16:26 INFO - [ 12:16:26 INFO - "pgo_build", 12:16:26 INFO - "False", 12:16:26 INFO - "Change" 12:16:26 INFO - ] 12:16:26 INFO - ], 12:16:26 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:26 INFO - } 12:16:26 INFO - ], 12:16:26 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:26 INFO - } 12:16:26 INFO - } 12:16:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:16:26 INFO - Running post-action listener: _resource_record_post_action 12:16:26 INFO - ##### 12:16:26 INFO - ##### Running download-and-extract step. 12:16:26 INFO - ##### 12:16:26 INFO - Running pre-action listener: _resource_record_pre_action 12:16:26 INFO - Running main action method: download_and_extract 12:16:26 INFO - mkdir: /builds/slave/test/build/tests 12:16:26 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')]} 12:16:26 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:26 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:26 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:26 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:27 INFO - Downloaded 1302 bytes. 12:16:27 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:27 INFO - Using the following test package requirements: 12:16:27 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:27 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:27 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'jsshell-linux-x86_64.zip'], 12:16:27 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:27 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:27 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:27 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:27 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:27 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:27 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:27 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:27 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:27 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:28 INFO - Downloaded 21339409 bytes. 12:16:28 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 12:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:28 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 12:16:29 INFO - Return code: 0 12:16:29 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 12:16:29 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')]} 12:16:29 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:30 INFO - Downloaded 21339409 bytes. 12:16:30 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 12:16:30 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:30 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 12:16:31 INFO - Return code: 0 12:16:31 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')]} 12:16:31 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:31 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:32 INFO - Downloaded 11130997 bytes. 12:16:32 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 12:16:32 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:32 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 12:16:33 INFO - Return code: 0 12:16:33 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')]} 12:16:33 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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 12:16:35 INFO - Downloaded 55909927 bytes. 12:16:35 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:35 INFO - mkdir: /builds/slave/test/properties 12:16:35 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:35 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:35 INFO - Contents: 12:16:35 INFO - build_url:https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:35 INFO - Running post-action listener: _resource_record_post_action 12:16:35 INFO - Running post-action listener: set_extra_try_arguments 12:16:35 INFO - ##### 12:16:35 INFO - ##### Running populate-webroot step. 12:16:35 INFO - ##### 12:16:35 INFO - Running pre-action listener: _resource_record_pre_action 12:16:35 INFO - Running main action method: populate_webroot 12:16:35 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:35 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:35 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:35 INFO - '../fennec_ids.txt'], 12:16:35 INFO - 'tests': ['tcheck2']}, 12:16:35 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:35 INFO - '--tppagecycles', 12:16:35 INFO - '7'], 12:16:35 INFO - 'tests': ['tsvgm']}}, 12:16:35 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:35 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:35 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:35 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:35 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:35 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:35 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'tests': ['damp', 'tps']}, 12:16:35 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['damp', 'tps']}, 12:16:35 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:35 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:35 INFO - 'other': {'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'other_l64': {'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:35 INFO - 'ts_paint', 12:16:35 INFO - 'tpaint', 12:16:35 INFO - 'sessionrestore', 12:16:35 INFO - 'sessionrestore_no_auto_restore']}, 12:16:35 INFO - 'svgr': {'tests': ['tsvgx', 12:16:35 INFO - 'tsvgr_opacity', 12:16:35 INFO - 'tart', 12:16:35 INFO - 'tscrollx', 12:16:35 INFO - 'cart']}, 12:16:35 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['tsvgx', 12:16:35 INFO - 'tsvgr_opacity', 12:16:35 INFO - 'tart', 12:16:35 INFO - 'tscrollx', 12:16:35 INFO - 'cart']}, 12:16:35 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'tests': ['tp5o']}, 12:16:35 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'talos_options': ['--e10s'], 12:16:35 INFO - 'tests': ['tp5o']}, 12:16:35 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'talos_options': ['--xperf_path', 12:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:35 INFO - 'tests': ['tp5n']}, 12:16:35 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:35 INFO - 'talos_options': ['--e10s', 12:16:35 INFO - '--xperf_path', 12:16:35 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:35 INFO - 'tests': ['tp5n']}}, 12:16:35 INFO - 'talos.zip': {'path': '', 12:16:35 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:35 INFO - Running post-action listener: _resource_record_post_action 12:16:35 INFO - ##### 12:16:35 INFO - ##### Running create-virtualenv step. 12:16:35 INFO - ##### 12:16:35 INFO - Running pre-action listener: _resource_record_pre_action 12:16:35 INFO - Running main action method: create_virtualenv 12:16:35 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:35 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 12:16:35 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:35 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:35 INFO - Using real prefix '/usr' 12:16:35 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:35 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:37 INFO - Installing pip.................done. 12:16:37 INFO - Return code: 0 12:16:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:37 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:37 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 12:16:37 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 12:16:37 INFO - Using env: {'DISPLAY': ':0', 12:16:37 INFO - 'HOME': '/home/cltbld', 12:16:37 INFO - 'LANG': 'en_US.UTF-8', 12:16:37 INFO - 'LANGUAGE': 'en_US:en', 12:16:37 INFO - 'LOGNAME': 'cltbld', 12:16:37 INFO - 'MAIL': '/var/mail/cltbld', 12:16:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:37 INFO - 'MOZ_NO_REMOTE': '1', 12:16:37 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:37 INFO - 'NO_EM_RESTART': '1', 12:16:37 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:37 INFO - 'PWD': '/builds/slave/test', 12:16:37 INFO - 'SHELL': '/bin/bash', 12:16:37 INFO - 'SHLVL': '1', 12:16:37 INFO - 'TERM': 'linux', 12:16:37 INFO - 'TMOUT': '86400', 12:16:37 INFO - 'USER': 'cltbld', 12:16:37 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:37 INFO - '_': '/tools/buildbot/bin/python'} 12:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:38 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 12:16:38 INFO - Cleaning up... 12:16:38 INFO - Return code: 0 12:16:38 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:38 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:38 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 12:16:38 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 12:16:38 INFO - Using env: {'DISPLAY': ':0', 12:16:38 INFO - 'HOME': '/home/cltbld', 12:16:38 INFO - 'LANG': 'en_US.UTF-8', 12:16:38 INFO - 'LANGUAGE': 'en_US:en', 12:16:38 INFO - 'LOGNAME': 'cltbld', 12:16:38 INFO - 'MAIL': '/var/mail/cltbld', 12:16:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:38 INFO - 'MOZ_NO_REMOTE': '1', 12:16:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:38 INFO - 'NO_EM_RESTART': '1', 12:16:38 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:38 INFO - 'PWD': '/builds/slave/test', 12:16:38 INFO - 'SHELL': '/bin/bash', 12:16:38 INFO - 'SHLVL': '1', 12:16:38 INFO - 'TERM': 'linux', 12:16:38 INFO - 'TMOUT': '86400', 12:16:38 INFO - 'USER': 'cltbld', 12:16:38 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:38 INFO - '_': '/tools/buildbot/bin/python'} 12:16:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:38 INFO - Downloading/unpacking psutil>=0.7.1 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:38 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 12:16:39 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:40 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:40 INFO - Installing collected packages: psutil 12:16:40 INFO - Running setup.py install for psutil 12:16:40 INFO - building 'psutil._psutil_linux' extension 12:16:40 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 12:16:40 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 12:16:40 INFO - building 'psutil._psutil_posix' extension 12:16:40 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 12:16:40 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 12:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:40 INFO - Successfully installed psutil 12:16:40 INFO - Cleaning up... 12:16:40 INFO - Return code: 0 12:16:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:40 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:40 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 12:16:40 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 12:16:40 INFO - Using env: {'DISPLAY': ':0', 12:16:40 INFO - 'HOME': '/home/cltbld', 12:16:40 INFO - 'LANG': 'en_US.UTF-8', 12:16:40 INFO - 'LANGUAGE': 'en_US:en', 12:16:40 INFO - 'LOGNAME': 'cltbld', 12:16:40 INFO - 'MAIL': '/var/mail/cltbld', 12:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:40 INFO - 'MOZ_NO_REMOTE': '1', 12:16:40 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:40 INFO - 'NO_EM_RESTART': '1', 12:16:40 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:40 INFO - 'PWD': '/builds/slave/test', 12:16:40 INFO - 'SHELL': '/bin/bash', 12:16:40 INFO - 'SHLVL': '1', 12:16:40 INFO - 'TERM': 'linux', 12:16:40 INFO - 'TMOUT': '86400', 12:16:40 INFO - 'USER': 'cltbld', 12:16:40 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:40 INFO - '_': '/tools/buildbot/bin/python'} 12:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:40 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 12:16:40 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 12:16:40 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 12:16:40 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 12:16:40 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 12:16:40 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 12:16:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:42 INFO - Installing collected packages: mozsystemmonitor 12:16:42 INFO - Running setup.py install for mozsystemmonitor 12:16:42 INFO - Successfully installed mozsystemmonitor 12:16:42 INFO - Cleaning up... 12:16:42 INFO - Return code: 0 12:16:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:42 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:42 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 12:16:42 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 12:16:42 INFO - Using env: {'DISPLAY': ':0', 12:16:42 INFO - 'HOME': '/home/cltbld', 12:16:42 INFO - 'LANG': 'en_US.UTF-8', 12:16:42 INFO - 'LANGUAGE': 'en_US:en', 12:16:42 INFO - 'LOGNAME': 'cltbld', 12:16:42 INFO - 'MAIL': '/var/mail/cltbld', 12:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:42 INFO - 'MOZ_NO_REMOTE': '1', 12:16:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:42 INFO - 'NO_EM_RESTART': '1', 12:16:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:42 INFO - 'PWD': '/builds/slave/test', 12:16:42 INFO - 'SHELL': '/bin/bash', 12:16:42 INFO - 'SHLVL': '1', 12:16:42 INFO - 'TERM': 'linux', 12:16:42 INFO - 'TMOUT': '86400', 12:16:42 INFO - 'USER': 'cltbld', 12:16:42 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:42 INFO - '_': '/tools/buildbot/bin/python'} 12:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:43 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 12:16:43 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 12:16:43 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 12:16:43 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 12:16:43 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 12:16:43 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 12:16:44 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:44 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 12:16:44 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 12:16:44 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 12:16:44 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 12:16:44 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 12:16:44 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 12:16:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:45 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 12:16:45 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 12:16:45 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 12:16:45 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 12:16:45 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 12:16:45 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 12:16:45 INFO - Downloading docopt-0.6.1.tar.gz 12:16:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:45 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:45 INFO - Running setup.py install for blobuploader 12:16:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:45 INFO - Running setup.py install for requests 12:16:45 INFO - Running setup.py install for docopt 12:16:45 INFO - Successfully installed blobuploader requests docopt 12:16:45 INFO - Cleaning up... 12:16:46 INFO - Return code: 0 12:16:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:46 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:46 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 12:16:46 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 12:16:46 INFO - Using env: {'DISPLAY': ':0', 12:16:46 INFO - 'HOME': '/home/cltbld', 12:16:46 INFO - 'LANG': 'en_US.UTF-8', 12:16:46 INFO - 'LANGUAGE': 'en_US:en', 12:16:46 INFO - 'LOGNAME': 'cltbld', 12:16:46 INFO - 'MAIL': '/var/mail/cltbld', 12:16:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:46 INFO - 'MOZ_NO_REMOTE': '1', 12:16:46 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:46 INFO - 'NO_EM_RESTART': '1', 12:16:46 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:46 INFO - 'PWD': '/builds/slave/test', 12:16:46 INFO - 'SHELL': '/bin/bash', 12:16:46 INFO - 'SHLVL': '1', 12:16:46 INFO - 'TERM': 'linux', 12:16:46 INFO - 'TMOUT': '86400', 12:16:46 INFO - 'USER': 'cltbld', 12:16:46 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:46 INFO - '_': '/tools/buildbot/bin/python'} 12:16:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:46 INFO - Running setup.py (path:/tmp/pip-soDfyo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:46 INFO - Running setup.py (path:/tmp/pip-MHTMKu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:46 INFO - Running setup.py (path:/tmp/pip-qriXlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:46 INFO - Running setup.py (path:/tmp/pip-1iBBij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:46 INFO - Running setup.py (path:/tmp/pip-g4RD1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:46 INFO - Running setup.py (path:/tmp/pip-mFJij1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:46 INFO - Running setup.py (path:/tmp/pip-b5h7N_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:46 INFO - Running setup.py (path:/tmp/pip-T9E1d6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:46 INFO - Running setup.py (path:/tmp/pip-iC1qi3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:46 INFO - Running setup.py (path:/tmp/pip-eBYDCk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:46 INFO - Running setup.py (path:/tmp/pip-Ti5nYK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:47 INFO - Running setup.py (path:/tmp/pip-hyp0vF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:47 INFO - Running setup.py (path:/tmp/pip-pIRkyJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:47 INFO - Running setup.py (path:/tmp/pip-AFQSJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:47 INFO - Running setup.py (path:/tmp/pip-GarUkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:47 INFO - Running setup.py (path:/tmp/pip-zuy93n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:47 INFO - Running setup.py (path:/tmp/pip-YoMcUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:47 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:47 INFO - Running setup.py install for manifestparser 12:16:47 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:47 INFO - Running setup.py install for mozcrash 12:16:47 INFO - Running setup.py install for mozdebug 12:16:47 INFO - Running setup.py install for mozdevice 12:16:47 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:47 INFO - Running setup.py install for mozfile 12:16:48 INFO - Running setup.py install for mozhttpd 12:16:48 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozinfo 12:16:48 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozInstall 12:16:48 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozleak 12:16:48 INFO - Running setup.py install for mozlog 12:16:48 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for moznetwork 12:16:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozprocess 12:16:48 INFO - Running setup.py install for mozprofile 12:16:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozrunner 12:16:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:48 INFO - Running setup.py install for mozscreenshot 12:16:49 INFO - Running setup.py install for moztest 12:16:49 INFO - Running setup.py install for mozversion 12:16:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:49 INFO - Cleaning up... 12:16:49 INFO - Return code: 0 12:16:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:49 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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:49 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 12:16:49 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 12:16:49 INFO - Using env: {'DISPLAY': ':0', 12:16:49 INFO - 'HOME': '/home/cltbld', 12:16:49 INFO - 'LANG': 'en_US.UTF-8', 12:16:49 INFO - 'LANGUAGE': 'en_US:en', 12:16:49 INFO - 'LOGNAME': 'cltbld', 12:16:49 INFO - 'MAIL': '/var/mail/cltbld', 12:16:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:49 INFO - 'MOZ_NO_REMOTE': '1', 12:16:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:49 INFO - 'NO_EM_RESTART': '1', 12:16:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:49 INFO - 'PWD': '/builds/slave/test', 12:16:49 INFO - 'SHELL': '/bin/bash', 12:16:49 INFO - 'SHLVL': '1', 12:16:49 INFO - 'TERM': 'linux', 12:16:49 INFO - 'TMOUT': '86400', 12:16:49 INFO - 'USER': 'cltbld', 12:16:49 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:49 INFO - '_': '/tools/buildbot/bin/python'} 12:16:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:49 INFO - Running setup.py (path:/tmp/pip-bXMiNk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:49 INFO - Running setup.py (path:/tmp/pip-idJavv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:49 INFO - Running setup.py (path:/tmp/pip-WE3RFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:49 INFO - Running setup.py (path:/tmp/pip-xqQgt3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:49 INFO - Running setup.py (path:/tmp/pip-nzTPwl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:49 INFO - Running setup.py (path:/tmp/pip-FHQYvC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:49 INFO - Running setup.py (path:/tmp/pip-3Bg5m9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:49 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)) 12:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:49 INFO - Running setup.py (path:/tmp/pip-kSYud6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:50 INFO - Running setup.py (path:/tmp/pip-wHNGZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:50 INFO - Running setup.py (path:/tmp/pip-kgLpog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:50 INFO - Running setup.py (path:/tmp/pip-2XCdLp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:50 INFO - Running setup.py (path:/tmp/pip-t_1c63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:50 INFO - Running setup.py (path:/tmp/pip-73afHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:50 INFO - Running setup.py (path:/tmp/pip-RsfFl_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:50 INFO - Running setup.py (path:/tmp/pip-lQBADY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:50 INFO - Running setup.py (path:/tmp/pip-K9puMf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:50 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)) 12:16:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:50 INFO - Running setup.py (path:/tmp/pip-8qGNBz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:50 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)) 12:16:50 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)) 12:16:50 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)) 12:16:50 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)) 12:16:50 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)) 12:16:50 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)) 12:16:50 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:52 INFO - Downloading blessings-1.5.1.tar.gz 12:16:52 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 12:16:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:52 INFO - Installing collected packages: blessings 12:16:52 INFO - Running setup.py install for blessings 12:16:52 INFO - Successfully installed blessings 12:16:52 INFO - Cleaning up... 12:16:52 INFO - Return code: 0 12:16:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:52 INFO - Reading from file tmpfile_stdout 12:16:52 INFO - Current package versions: 12:16:52 INFO - argparse == 1.2.1 12:16:52 INFO - blessings == 1.5.1 12:16:52 INFO - blobuploader == 1.2.4 12:16:52 INFO - docopt == 0.6.1 12:16:52 INFO - manifestparser == 1.1 12:16:52 INFO - mozInstall == 1.12 12:16:52 INFO - mozcrash == 0.16 12:16:52 INFO - mozdebug == 0.1 12:16:52 INFO - mozdevice == 0.47 12:16:52 INFO - mozfile == 1.2 12:16:52 INFO - mozhttpd == 0.7 12:16:52 INFO - mozinfo == 0.9 12:16:52 INFO - mozleak == 0.1 12:16:52 INFO - mozlog == 3.0 12:16:52 INFO - moznetwork == 0.27 12:16:52 INFO - mozprocess == 0.22 12:16:52 INFO - mozprofile == 0.27 12:16:52 INFO - mozrunner == 6.11 12:16:52 INFO - mozscreenshot == 0.1 12:16:52 INFO - mozsystemmonitor == 0.0 12:16:52 INFO - moztest == 0.7 12:16:52 INFO - mozversion == 1.4 12:16:52 INFO - psutil == 3.1.1 12:16:52 INFO - requests == 1.2.3 12:16:52 INFO - wsgiref == 0.1.2 12:16:52 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16: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')]} 12:16:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16: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')]} 12:16:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3ca623dc70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0xfd86c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1089900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, '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': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', '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 12:16:52 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 12:16:52 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 12:16:52 INFO - Using env: {'DISPLAY': ':0', 12:16:52 INFO - 'HOME': '/home/cltbld', 12:16:52 INFO - 'LANG': 'en_US.UTF-8', 12:16:52 INFO - 'LANGUAGE': 'en_US:en', 12:16:52 INFO - 'LOGNAME': 'cltbld', 12:16:52 INFO - 'MAIL': '/var/mail/cltbld', 12:16:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:52 INFO - 'MOZ_NO_REMOTE': '1', 12:16:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:52 INFO - 'NO_EM_RESTART': '1', 12:16:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:52 INFO - 'PWD': '/builds/slave/test', 12:16:52 INFO - 'SHELL': '/bin/bash', 12:16:52 INFO - 'SHLVL': '1', 12:16:52 INFO - 'TERM': 'linux', 12:16:52 INFO - 'TMOUT': '86400', 12:16:52 INFO - 'USER': 'cltbld', 12:16:52 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:16:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:52 INFO - '_': '/tools/buildbot/bin/python'} 12:16:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 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)) 12:16:53 INFO - Cleaning up... 12:16:53 INFO - Return code: 0 12:16:53 INFO - Running post-action listener: _resource_record_post_action 12:16:53 INFO - Running post-action listener: _start_resource_monitoring 12:16:53 INFO - Starting resource monitoring. 12:16:53 INFO - ##### 12:16:53 INFO - ##### Running install step. 12:16:53 INFO - ##### 12:16:53 INFO - Running pre-action listener: _resource_record_pre_action 12:16:53 INFO - Running main action method: install 12:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:53 INFO - Reading from file tmpfile_stdout 12:16:53 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:53 INFO - Reading from file tmpfile_stdout 12:16:53 INFO - Output received: 12:16:53 INFO - Usage: mozinstall [options] installer 12:16:53 INFO - Options: 12:16:53 INFO - -h, --help show this help message and exit 12:16:53 INFO - -d DEST, --destination=DEST 12:16:53 INFO - Directory to install application into. [default: 12:16:53 INFO - "/builds/slave/test"] 12:16:53 INFO - --app=APP Application being installed. [default: firefox] 12:16:53 INFO - mkdir: /builds/slave/test/build/application 12:16:53 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'] 12:16:53 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 12:17:07 INFO - Reading from file tmpfile_stdout 12:17:07 INFO - Output received: 12:17:07 INFO - /builds/slave/test/build/application/firefox/firefox 12:17:07 INFO - Running post-action listener: _resource_record_post_action 12:17:07 INFO - ##### 12:17:07 INFO - ##### Running run-tests step. 12:17:07 INFO - ##### 12:17:07 INFO - Running pre-action listener: _resource_record_pre_action 12:17:07 INFO - Running main action method: run_tests 12:17:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:17:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:17:07 INFO - Python 2.7.3 12:17:07 INFO - Return code: 0 12:17:07 INFO - grabbing minidump binary from tooltool 12:17:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:07 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 0x10cfb70>, '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 0x1120dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1121250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:17:07 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 12:17:07 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 12:17:07 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:17:07 INFO - Return code: 0 12:17:07 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:17:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:17:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:17:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:17:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:17:07 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/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] in /builds/slave/test/build 12:17:07 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/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-023 --webServer localhost 12:17:07 INFO - Using env: {'DISPLAY': ':0', 12:17:07 INFO - 'HOME': '/home/cltbld', 12:17:07 INFO - 'LANG': 'en_US.UTF-8', 12:17:07 INFO - 'LANGUAGE': 'en_US:en', 12:17:07 INFO - 'LOGNAME': 'cltbld', 12:17:07 INFO - 'MAIL': '/var/mail/cltbld', 12:17:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:17:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:17:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:07 INFO - 'MOZ_NO_REMOTE': '1', 12:17:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:17:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:07 INFO - 'NO_EM_RESTART': '1', 12:17:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:07 INFO - 'PWD': '/builds/slave/test', 12:17:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:17:07 INFO - 'SHELL': '/bin/bash', 12:17:07 INFO - 'SHLVL': '1', 12:17:07 INFO - 'TERM': 'linux', 12:17:07 INFO - 'TMOUT': '86400', 12:17:07 INFO - 'USER': 'cltbld', 12:17:07 INFO - 'XDG_SESSION_COOKIE': 'e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599', 12:17:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:07 INFO - '_': '/tools/buildbot/bin/python'} 12:17:07 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/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-023', '--webServer', 'localhost'] with output_timeout 3600 12:17:07 INFO - mozversion INFO | application_buildid: 20151121014332 12:17:07 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 12:17:07 INFO - mozversion INFO | application_display_name: Nightly 12:17:07 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:17:07 INFO - mozversion INFO | application_name: Firefox 12:17:07 INFO - mozversion INFO | application_remotingname: firefox 12:17:07 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:17:07 INFO - mozversion INFO | application_vendor: Mozilla 12:17:07 INFO - mozversion INFO | application_version: 45.0a1 12:17:07 INFO - mozversion INFO | platform_buildid: 20151121014332 12:17:07 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 12:17:07 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:17:07 INFO - mozversion INFO | platform_version: 45.0a1 12:17:07 INFO - 2015-11-23 12:17:07,764 DEBUG : using testdate: 1448309827 12:17:07 INFO - 2015-11-23 12:17:07,764 DEBUG : actual date: 1448309827 12:17:07 INFO - 2015-11-23 12:17:07,772 INFO : starting webserver on 'localhost:40995' 12:17:07 INFO - 2015-11-23 12:17:07,773 INFO : Starting test suite talos-linux64-ix-023 12:17:07 INFO - 2015-11-23 12:17:07,773 INFO : Starting test dromaeo_css 12:17:07 INFO - 2015-11-23 12:17:07,773 DEBUG : operating with platform_type : linux_ 12:17:07 INFO - 2015-11-23 12:17:07,774 INFO : Initialising browser for dromaeo_css test... 12:17:07 INFO - 2015-11-23 12:17:07,781 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYONeFz/profile http://localhost:40995/getInfo.html 12:17:12 INFO - 2015-11-23 12:17:12,898 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:17:12 INFO - 2015-11-23 12:17:12,898 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:17:12 INFO - 2015-11-23 12:17:12,898 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:17:12 INFO - 2015-11-23 12:17:12,898 DEBUG : BROWSER_OUTPUT: __metrics 12:17:13 INFO - 2015-11-23 12:17:13,047 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:17:14 INFO - 2015-11-23 12:17:14,351 INFO : Browser initialized. 12:17:14 INFO - 2015-11-23 12:17:14,352 INFO : Running cycle 1/1 for dromaeo_css test... 12:17:14 INFO - 2015-11-23 12:17:14,352 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpYONeFz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:26 INFO - 2015-11-23 12:17:26,305 DEBUG : BROWSER_OUTPUT: RSS: Main: 140017664 12:17:26 INFO - 2015-11-23 12:17:26,305 DEBUG : BROWSER_OUTPUT: 12:18:17 INFO - 2015-11-23 12:18:17,801 DEBUG : BROWSER_OUTPUT: 1448309897798 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] 12:20:30 INFO - 2015-11-23 12:20:30,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-dojo.html (next: http://localhost:40995/tests/dromaeo/cssquery-ext.html) 12:20:31 INFO - 2015-11-23 12:20:31,371 DEBUG : BROWSER_OUTPUT: RSS: Main: 244350976 12:20:31 INFO - 2015-11-23 12:20:31,372 DEBUG : BROWSER_OUTPUT: 12:23:33 INFO - 2015-11-23 12:23:33,842 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-ext.html (next: http://localhost:40995/tests/dromaeo/cssquery-jquery.html) 12:23:34 INFO - 2015-11-23 12:23:34,408 DEBUG : BROWSER_OUTPUT: RSS: Main: 220737536 12:23:34 INFO - 2015-11-23 12:23:34,408 DEBUG : BROWSER_OUTPUT: 12:26:36 INFO - 2015-11-23 12:26:36,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-jquery.html (next: http://localhost:40995/tests/dromaeo/cssquery-mootools.html) 12:26:37 INFO - 2015-11-23 12:26:37,029 DEBUG : BROWSER_OUTPUT: RSS: Main: 212029440 12:26:37 INFO - 2015-11-23 12:26:37,029 DEBUG : BROWSER_OUTPUT: 12:29:38 INFO - 2015-11-23 12:29:38,981 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-mootools.html (next: http://localhost:40995/tests/dromaeo/cssquery-prototype.html) 12:29:39 INFO - 2015-11-23 12:29:39,548 DEBUG : BROWSER_OUTPUT: RSS: Main: 200196096 12:29:39 INFO - 2015-11-23 12:29:39,548 DEBUG : BROWSER_OUTPUT: 12:32:42 INFO - 2015-11-23 12:32:42,268 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-prototype.html (next: http://localhost:40995/tests/dromaeo/cssquery-yui.html) 12:32:42 INFO - 2015-11-23 12:32:42,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 205860864 12:32:42 INFO - 2015-11-23 12:32:42,854 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,274 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/dromaeo/cssquery-yui.html (next: http://localhost:40995/tests/dromaeo/cssquery-dojo.html) 12:35:45 INFO - 2015-11-23 12:35:45,524 DEBUG : BROWSER_OUTPUT: RSS: Main: 248381440 12:35:45 INFO - 2015-11-23 12:35:45,524 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,524 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:45 INFO - 2015-11-23 12:35:45,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:45 INFO - 2015-11-23 12:35:45,524 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:45 INFO - 2015-11-23 12:35:45,525 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:45 INFO - 2015-11-23 12:35:45,525 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2640.84154950703;2719.456108778245;2721.0680416903997;2735.411886444414;2740.177946616016;4508.053308805147;4629.189891768944;4638;4712.98670785781;4718.858434246969;4524.3213517972235;4593.242115051013;4604.631629469643;4614.630829533638;4617.2150734375155;4318.114786468782;4336.154449882274;4337.609615134637;4368.934465983013;4374.518802931675;4161.729487583312;4362.214801335758;4373.781310934456;4427.579379958899;4456.3315502674695;4267.8079486423185;4284.807183676711;4335.7181783184;4338.674599405026;4368.4102646143;4356.455443069616;4401.22978478765;4406.25093734066;4410.735355878657;4455.799489023002;4106.733062350938;4386.254336762758;4390.912181756379;4419.53594872537;4441.089576636814;4490.910181796378;4538.228501154778;4619.676622636417;4733.219018861883;4766.046790641885;4997.225430058346;5023.874403139914;5024.547790698818;5032.245163225509;5066.82266120684;4699.835505757316;5068.366454193226;5070.163423035195;5072.644914855961;5073.188289873639;4625.098105869391;4639.791209395586;4653.650976176733;4726.125666751662;4791.760411979387;5170.844874653766;5171;5171.2501687255135;5174.508421700008;5228.92156617651;4738.3129446230105;4977.0792403405485;4978;4979.327790748275;5029.698218106925;4907.558319751168;4920.852374428773;4928.802847886116;5018.924716129261;5041.79832806691;4970.478099799541;4971.130052240844;4971.477994810565;4972.030454061495;5021.899562008813;4721.811127554859;4941.283513890466;4945.184044632595;4950.331705219749;4997.85006449807;4112.650424713933;4132.173565286955;4140.047789008485;4169.145325208325;4193.475815523059;3670.064133645903;3685.0418891087975;3688.55737311519;3693.169036966661;3710.888673339804;4355.673324500612;4364.476262848479;4369.628581570539;4370.737755734666;4407.823687052482;4838.104950584153;4953.554180123734;4964.180910149785;5005.1491246488185;5014.272930425068;4395.7142785718825;4404.933925991113;4410.647148228134;4435.889102772457;4450.332450132506;4534.478534968521;4540.523245059288;4545;4555.703879247838;4582.450105987303;4577.793999269974;4682.765861706833;4683.227267500824;4684.50812664679;4870.8782280442565;4917.409910810583;4975.253711943237;4992.500749924979;4997.625178111583;5040.84877453677;4827.396575428072;4829.203181475017;4831.661783675109;4837.806487740591;4873.269009648581;4755.809767609257;4863.537963893425;5025;5032.924506132338;5072.644914855925;4906.705597664151;4985.850424487271;5068.2904393384215;5076.162433198481;5119.180931051163;4868.951310486991;4879.609631229564;4882.267659851051;4884.218525035977;4929.260610908393;4573.359729637787;4697.201475749199;4888.58447031992;4889.535494128052;4927.088488629615;4683.297505374221;4759;4806.182948898766;4811.037792441456;4868.732219727949;4945.282933974481;4966.205407134841;4971.975140124277;4979.502049794992;4982.177940639754;4534.410526631649;4623.190941585276;4879.609631229422;4880.755962201947;4918.016396720742 12:35:45 INFO - 2015-11-23 12:35:45,528 DEBUG : BROWSER_OUTPUT: |1;ext.html;559.3958524793222;569.7863301262026;576.9931469585574;580.2543731305273;582.9300483941928;27608.17175484736;35741.82129089354;36905;36920;36948.63051369486;39701.20597588047;40333;40418.59581404185;40428.19143617126;40440.191196176056;6977.511574189809;7102.822429439254;7650.120236172828;8098.919010809905;8107.797305067362;10158.74603134924;10346.741331466697;10371.688849334494;10417.062464378205;10421.531031103581;10127.49362531874;10235.130013948823;10238.692839214835;10243.795124097514;10246.89753102467;7117.3238542338395;7290.74482393119;7303.196648368676;7312.37844783194;10044.54799534019;7009.929900700979;10273.589056437733;10476.52855621499;10490.790184196274;10532.473376331152;36986.26027479435;37220.25559488822;37409.25181496355;37425;37520.81239593812;2948.3808400235976;3015.9698403016127;3024.833634150121;3518.3315170117853;3666.211764470652;24039.87980060106;28448;28656.856715716498;29207.56188657172;29701.405971880657;3369.578802649669;3451.8274086295837;3455.7580969332157;3577.266660334625;3601.927961440783;238168;240910;241896;242353;242505.7874710633;52372.738136309075;53460.73269633627;57805;58269.70865145647;58396.416035839095;66606.33393666001;68220.6588967052;68458.31541684619;68507.3149268501;68531.65734171297;12585.874141258653;12818.871811281955;12824.422900969479;12825.29460879642;12829.10196286251;9307.11582399671;9337.439753614804;9363.672271470467;9375.203107735919;9398.718038458721;19347;19726.153400086845;19758.40724778259;19776.70334944977;19820.40538783839;7779.338756205672;7879.921200788033;7895.44704882805;7897.763067107996;7952.085510166289;829.8340331933516;841.3059226138461;893.4862454088925;905.4702998745676;1035.404642330663;25825.483490330087;26066;26082.478350432884;29297.85351073231;30877.78353184848;888.8000199955088;897.7531178925848;915.8203475727726;915.8580420034905;922.285228947571;13119.803202951964;13585.388657510435;13694.589162325146;13809.585712428643;13811.240381779098;345323;351956;352456;352609;353410;44943.77528112339;45932.54067459283;47265.76367118143;47648.761756190994;47724.522754772705;1161.0653423993597;1220.5178954313174;1226.1171956191529;1232.4577186038293;1233.543588872123;26399.076032338777;26408.075717349802;26461.603075954263;27036.32409189786;27124.864375677997;35226.119347015505;36046.45930310995;37681.623183768905;40536.59463405328;41446.58553414427;176278;176555;177601;177652;178025;27264.318392039564;27476.862615686794;27602.861985689942;27604.585931211448;27612.447751045267;34248.65751342455;44034.55965440305;45773.54226457693;45998;46945.29582056204;33023.339533209684;33759;34292.31415371629;34648.82675586606;34706.82646586751;33652.83173584214;34019.65980340165;34131.48802767911;34341.31317373688;34359.31281374308;33565.496517551765;34416.31167376688;34512.65487345094;34524.48213276752;34535.65464345425;28514.14457566276;30893.227669308446;31188.844055779577;31194.181106568147;31352.52971205388;24304.392390190387;24310.392240194138;24526;24574.877125614257;24734.38164045913 12:35:45 INFO - 2015-11-23 12:35:45,530 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.12501433822257;343.9982800085999;344.1224876564759;345.47315344100247;345.5438820756602;12669;12916.870831291684;16079.75880361794;16323.673526529463;17127.828721712795;10011.197984362812;10205.336653117542;10228.846567301496;14354.497592584261;14617.853821461782;4462.1521910837;4585.701929374597;4597.37935378723;4600.746958917258;4602.987342784599;3391.3725960697225;3449.4480883058714;3449.862005519776;3450.7756995795316;4988.900221995558;5153.072446959546;5277.261183434322;5284.207368894658;5288.8413347599635;5315.973420132913;4974.403071631409;5044.142495775727;5116.667416617908;5307.495787900143;5307.575393968474;4781.569658730731;4899.681520701143;4903.2645103234445;4909.6072314215135;4909.68087074339;11774.882251177463;11989.580364687194;11995.280283183038;11999.46002429884;16380.508584742358;1762.903040332794;1795.4523870219577;1852.1480119145074;1945.2121890634317;2003.8697484663596;9280.860787088199;10009.29934904557;10285.382877027403;11235.382053987027;13001;1755.2452445448453;1758.2878934031737;1790.534461040126;1800.0369802155915;1812.8459080978132;52930;56055.71972140154;56239;56413;57805.99999999958;12265.466816647919;14735.484258050918;14824.481143160154;15046.774298385533;15997;22805.771942280364;23305.300840974796;23309.785570370786;23320.950557224965;23388.76611233866;7475.289847464483;7526.623668816537;7604.049493813273;7950.6422211000645;8016.198380161937;5956.463918247292;6156.0458128989185;6172.351903050115;6200.937990620036;6314.71583778731;7657.731979380695;7674.96162519195;7685.923140768633;7716.151223365426;7730.7680769577;1716.828317168273;1740.1212387744108;2202.361315218601;2917.693642167584;2994.77539184562;803.2730379007008;815.5432957543794;829.5520418973807;889.1775108025051;920.9593159729596;15979.440719574759;16020.439284624983;16031.278592463133;16294.592635184215;16351.427700030441;806.1978331560135;837.405442136078;851.8594431918788;853.3514528958036;858.6050416808213;7656.693732250759;8915.687950921687;9106.81786364269;9210.309226808016;9384.343095983351;467067;473871;493170;498835;502919;68442.65778671174;68498.65750671214;70633;73305;74565;1023.8157131716363;1040.557762950743;1041.7083216699489;1045.6810672744887;1047.4919663962971;14232.857671423568;14628;14677.119372837664;14774.63063423423;14925.626859328604;31928.52107218347;32238;32446.67553324531;32736.181595460304;33434;38147.809260953516;39577;39831;42239.788801055794;42887;8607.741767746978;8795.516246606498;9010.594523246338;9012.098790120936;9017.594208260512;15382.846171538142;15415.76876346878;15612.4535641252;15875.444359447363;15961.281742321855;12650.43073061696;12898.935505322788;13210.688129577093;13318.200907945555;13412.731745364843;12448.31534265624;13279.66800829987;13367.331633418486;13602.455901763818;14456;14117.43530258778;14171;14271.64320891986;14626;14765.261736913326;8466.238038576557;8790.252828509392;8801.823963520821;8823.823523529622;9211.170994610517;9814.509274536387;9901.702948911545;9933.552990115606;10912.290701104403;13393.799093013418 12:35:45 INFO - 2015-11-23 12:35:45,531 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1427.6002719238618;1623.3587732845524;1684.5788552861784;1700.0734599643192;1714.331410749808;5922.555808314378;6666.500012499064;6879;6889.242183359826;6898.551594146377;6723.4957378196705;6816.079829223054;6828.2488926218075;6833.350831670996;6839.726410943569;2078.896055197242;2095.224766836273;2097.590969760897;2099.6010757956014;2100.2544096845554;1935.680612698903;2097.797312821539;2115.7249557557498;2117.692934524493;2121.2681624839406;2022.8482863785275;2048.5288383671764;2058.53682921343;2059.6189704904564;2061.124022290528;2074.1392322186275;2077.9376618701463;2083.2083808152806;2087.0191010225244;2089.1747759634936;2063.030375723408;2074.6887966804948;2089.101686274901;2091.874487530753;2098.150249149097;5743.684097374643;5931.377205393414;6715.059891615178;6745.865082698368;6758.425533829631;3506.491558723996;3941.5861334559745;4083.4691490106393;4094.508658960914;4102.159057393227;2780.555111182201;2781.193453898367;2806.1020473448507;2820.675622303441;2863.954656550365;891.7503099132254;896.9820603587891;904.4166512599337;907.7458311672676;932.9486878221695;9002.549872506348;9068.183863452256;9068.773280668036;9080.40977336471;9109.043550427243;3955.9011024724614;3985.501812273466;4011.0774521860135;4026;4031.9798401007806;8044.758657240292;8045.597720113971;8080.232377924088;8094.757157285291;8110.391720620977;4182.100848317566;4183.5398106208295;4197.496300443905;4214.030772922184;4214.620684138442;3799.886003419902;3802.7908465034134;3825.081980324702;3838.0788610733225;3844.6732027777393;3273.7217336526187;3276.1973316537124;3288.1615188126875;3296.8681252750102;3308.6525914778604;1082.3938594387168;1082.8592283003318;1088.450332582041;1088.9945550272198;1097.742030622803;930.6417029443578;963.1909196275162;1144.9484773185227;1158.1314014489133;1163.8254261860789;6417.2299324081405;6445.581037232565;6450.354964503512;6494.253160886558;6494.383033611799;947;948.1324588002038;956.3879117364892;1018.2973748113777;1031.4687935713114;4567.155076310827;5128.153854614022;5131.2046632771235;5133.666311689728;5167.715775632376;7286.307800759026;7846.686132554748;8054.5569993650915;8055.436119471581;8079.03051633796;7891.723789667449;7899.447038707351;7901.723439679584;7904.6838126474295;7934.722284720007;6257.749690012349;6362.363763623601;6393.392627700361;6393.712282947278;6409.583377080568;6428.292887782433;6433.324500927335;6450.193725784277;6451.774187903401;6460.773872914613;7175.138983322035;7328.267173282629;7334.193238743841;7353.522021068614;7361.2638736125955;7310.890336645061;7467.1039475263315;7468.103827540513;7471.103467583925;7576.772696819105;5723.313202415737;5761.625494342854;5782.739776710142;5784.161296611884;5805.158252053513;6230.283517395376;6287.528435367457;6303.46420554258;6308.495320374451;6310.842228944313;5959.463648271676;6010;6034.426729460694;6088.391160883876;6092.390760923872;5688.7440065198;5882.029465138205;5934.673592952429;6133.202683651097;6134.693265336805;6082.787102451393;6109.144719739151;6144.8771024580155;6306.716197771203;6323.715432805627;5772.422757724362;5815.883682326245;5824.039033559416;5825.330087040044;5831.329397119385;5793.565482588739;5801.941980580309;5862.853428664317;5875.9423303805725;5876.970615146897 12:35:45 INFO - 2015-11-23 12:35:45,535 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.66066478535566;316.78616933569845;321.69599728256793;325.9967400325996;327.31427659054305;5228.424873263947;5277.287566178565;5353.197020446935;5388.568914486841;5440.319960004995;5161.767720452579;5302.204669299607;5314.495122963322;5343.145096784515;5344.198370244465;4182.477190351206;4182.498100227962;4188.204241194178;4196.328587426013;4230.91538169238;3997.1406147678244;4073;4082.0815316553835;4188.81150348235;4225.218334608092;4124.525679546846;4134.607212314825;4152.460180176573;4186.079062606237;4186.644135248507;4174.248635245639;4176.561461046576;4181.414601955728;4183.916321673565;4194.727342722713;3720.4605332226674;3725.050112221393;3728.1425272187275;3732.2722069196516;3734.3651579231596;5043;5165.896682066337;5167.948320516784;5169.353830771153;5176.430592634807;4847.903041939141;4853.538913803183;4855.101806165871;4855.902881942377;4858.5384388483035;5656;5667.149927510865;5668.064769313059;5668.57485688575;5670;4062.8577999770164;4065.125997910434;4069.7558146511305;4073.775942323171;4076.30702780528;5789.305283365981;5850.5612079094235;5937.851553711149;5946.554008449383;5954.374790647006;4181.289180839264;4184.4351012613515;4194.203101410722;4196.958030419718;4199.4120823084795;4246.193223287565;4253.659707223414;4253.659707223414;4254.915091605091;4256.510501292391;4802.73584952824;4810.927836082462;4812.326274321597;4815.3017812417;4817.012512434942;5498.697571633518;5648;5654.6324488908085;5657.4908258256955;5657.773689052474;1490.970180596382;1515.6210947263185;1515.8332583415815;1516.0145905161733;1516.385863725193;1031.7936412717336;1038.2576457832686;1040.9063184313447;1046.602291129366;1058.7035630023606;4967.403911530567;4975.154223781966;4985.152524070917;4986.376702912136;4990.30135780991;5695.971520142456;5837.445442682938;5864.325602555676;5867.647941123546;5873.119032145212;4863.927041094386;4948;5010.248462730619;5017.623678224148;5031.0441016206805;3131.498960166408;3181.44324743169;3185.601799775028;3185.7132858042423;3185.9203519911725;5577.776888924398;5588.9720551397795;5593.244911936918;5594.748236329375;5603.159526071122;5872.148538461899;6081.787137450168;6097.817065488042;6117.480014198843;6123.632582045091;5562.916556251659;5618.185363122325;5621.634593751393;5627.32472103342;5630.296212973379;5931.258592675916;5940.1683764272175;5944.613600115978;5944.613600115978;5947.256592925884;5672.858178545569;5786.9131963019745;5794.710264486843;5796.8550786229;5810.82567522975;5597.944020559742;5599.272094627672;5600.691961942132;5601.831945041656;5606.271184745957;4080.2451546464;4114.958850411457;4119.670426365943;4121.093359460914;4125.339945608688;5916.763329466945;5920.082387229986;5926.348101708722;5927.0220413633;5935.139404786368;5530.778768849362;5650.434956504317;5652.180433836988;5675.148727690879;5675.574331925205;5657.773689052557;5658.462446067617;5668.26312579362;5671.262735844314;5673.716314184357;5534.05920993424;5541.861453463534;5544.41783612731;5550.666959982414;5552.416996215339;5604.187392828098;5721.742521586455;5722.599418040697;5724.084146536534;5727.455891690282;5570.972145139248;5578.414266502121;5585.050541407889;5594.468525490072;5611.915821262766 12:35:45 INFO - 2015-11-23 12:35:45,536 DEBUG : BROWSER_OUTPUT: |5;yui.html;658.7694306992552;675.614899507281;739.8483310921262;760.3043215457857;766.6320166320166;10978.231523793327;11057.281276717007;11061.557537698493;11069.391183484906;11120.388378639193;10021.34861234021;10480.161587073035;11230.438478076105;11321.150913681466;11350.318980861133;788.8185717285043;805.963731632075;808.1595141053298;808.6563210635456;809.8866158737782;789.5381201996839;799.6401619271351;801.7755028592004;802.4984384759525;802.638812534359;829.8298848735994;838.7609531283586;839.8530257204995;840.1514470384894;841.154639587217;835.5028757889046;835.7409203147014;836.1513064239801;836.4646626159263;837.3803385494751;615.8799034188335;617.7220250887119;618.0667192539298;618.0975775367968;618.5700937848197;9994.700158995242;10086.445245511493;10099.848502272473;10110.140638045776;10123.29136960413;8420.915790842075;8712.346574006975;9045.954770226173;9701.563429645683;9759.804803903953;8533.957330213372;8564.057953625097;8637.784055398603;8658.220760131555;8678.86981695275;3003.189138932476;3042.4675681755602;3086.2901532647616;3176.65056843747;3186.5379519969706;33761;34154.14614634629;34154.779939303866;34157;39116.804415978026;8615.332607517666;9138.223251023737;9326.393784404128;9440.29197810167;9474.715758527118;15874;16105.27526261321;16133.67732645364;16146.919265403598;16170.75743863843;6333.65164915934;6335.873282534323;6397.61614303134;6401.231852177675;6421.711023003976;3231.5960504936884;3318.4856347266214;3409.2670075933793;3424.6575342466053;3765.3975363941636;2779.1801418581567;2783.9860800695865;2804.845733484678;2810.57841323799;2812.5640525718545;487.5563237453971;497.2615665736379;506.90115427491287;507.6091409614576;527.4751622135999;465.12556393979105;491.42748697767416;510.6757209172128;535.635767677975;626.3517259636254;7892.329152022143;7953.483023603563;7978.840423191504;8075.555844428495;8148.388870834592;558.1711158928987;565.7961347190414;569.4334137533181;574.8562859285179;622.5082185073832;3553.1650062235353;3566.4293713005795;3599.352116618981;3620.149264922741;3651.5253017107607;49839;50681;51060.744696276284;51193;51218.23172652413;45555;46136.3079553807;46262.306065409044;46385.5361446388;46660;39689.60310396859;39884.20231595352;44435.55564444314;46308.5369146311;46956.5304346959;8132.593370331578;8242.29940455068;8491.023532293866;8592.398532102943;8596.441231319945;31290.530642039932;31824;32385.838070810438;32417;32958;35910.28179436449;36220.27559448849;40790.38814417727;44298;44468.77765611151;9877.802443951225;9890.159336456481;9897.950510247403;10039.598416063276;10336.17310615134;10438.791224175626;10473.842892356774;10639.521221544894;10647.574097036342;11049.39228342449;10414.635487758194;10466.476676166008;10474.895251047392;10497.47512624381;10504.789904202025;10573.577056917944;10724.785504290026;10752.462376881282;10849.077828384676;10869.29349592274;10068.194544436574;10215.182785377003;10224.335418197794;10258.897411025795;10599.1520678344;9056.864147037932;9110;9369;9417.48203848795;9448.433094014381;8801.867971980297;8904.73285801427;8910.465372077697;8946;9213.447193168431 12:35:45 INFO - 2015-11-23 12:35:45,536 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:45 INFO - 2015-11-23 12:35:45,536 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:45 INFO - 2015-11-23 12:35:45,537 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,951 12:35:45 INFO - 2015-11-23 12:35:45,537 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:45 INFO - 2015-11-23 12:35:45,537 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310945521__endTimestamp 12:35:45 INFO - 2015-11-23 12:35:45,537 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,538 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:45 INFO - 2015-11-23 12:35:45,538 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:45 INFO - 2015-11-23 12:35:45,538 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,538 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4633.16 Median:4726.13 stddev:471.37 (10.0%) stddev-sans-first:446.16 12:35:45 INFO - 2015-11-23 12:35:45,539 DEBUG : BROWSER_OUTPUT: Values: 2640.8 2719.5 2721.1 2735.4 2740.2 4508.1 4629.2 4638.0 4713.0 4718.9 4524.3 4593.2 4604.6 4614.6 4617.2 4318.1 4336.2 4337.6 4368.9 4374.5 4161.7 4362.2 4373.8 4427.6 4456.3 4267.8 4284.8 4335.7 4338.7 4368.4 4356.5 4401.2 4406.3 4410.7 4455.8 4106.7 4386.3 4390.9 4419.5 4441.1 4490.9 4538.2 4619.7 4733.2 4766.0 4997.2 5023.9 5024.5 5032.2 5066.8 4699.8 5068.4 5070.2 5072.6 5073.2 4625.1 4639.8 4653.7 4726.1 4791.8 5170.8 5171.0 5171.3 5174.5 5228.9 4738.3 4977.1 4978.0 4979.3 5029.7 4907.6 4920.9 4928.8 5018.9 5041.8 4970.5 4971.1 4971.5 4972.0 5021.9 4721.8 4941.3 4945.2 4950.3 4997.9 4112.7 4132.2 4140.0 4169.1 4193.5 3670.1 3685.0 3688.6 3693.2 3710.9 4355.7 4364.5 4369.6 4370.7 4407.8 4838.1 4953.6 4964.2 5005.1 5014.3 4395.7 4404.9 4410.6 4435.9 4450.3 4534.5 4540.5 4545.0 4555.7 4582.5 4577.8 4682.8 4683.2 4684.5 4870.9 4917.4 4975.3 4992.5 4997.6 5040.8 4827.4 4829.2 4831.7 4837.8 4873.3 4755.8 4863.5 5025.0 5032.9 5072.6 4906.7 4985.9 5068.3 5076.2 5119.2 4869.0 4879.6 4882.3 4884.2 4929.3 4573.4 4697.2 4888.6 4889.5 4927.1 4683.3 4759.0 4806.2 4811.0 4868.7 4945.3 4966.2 4972.0 4979.5 4982.2 4534.4 4623.2 4879.6 4880.8 4918.0 12:35:45 INFO - 2015-11-23 12:35:45,539 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,539 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42254.43 Median:34387.81 stddev:70034.70 (203.7%) stddev-sans-first:70161.20 12:35:45 INFO - 2015-11-23 12:35:45,540 DEBUG : BROWSER_OUTPUT: Values: 559.4 569.8 577.0 580.3 582.9 27608.2 35741.8 36905.0 36920.0 36948.6 39701.2 40333.0 40418.6 40428.2 40440.2 6977.5 7102.8 7650.1 8098.9 8107.8 10158.7 10346.7 10371.7 10417.1 10421.5 10127.5 10235.1 10238.7 10243.8 10246.9 7117.3 7290.7 7303.2 7312.4 10044.5 7009.9 10273.6 10476.5 10490.8 10532.5 36986.3 37220.3 37409.3 37425.0 37520.8 2948.4 3016.0 3024.8 3518.3 3666.2 24039.9 28448.0 28656.9 29207.6 29701.4 3369.6 3451.8 3455.8 3577.3 3601.9 238168.0 240910.0 241896.0 242353.0 242505.8 52372.7 53460.7 57805.0 58269.7 58396.4 66606.3 68220.7 68458.3 68507.3 68531.7 12585.9 12818.9 12824.4 12825.3 12829.1 9307.1 9337.4 9363.7 9375.2 9398.7 19347.0 19726.2 19758.4 19776.7 19820.4 7779.3 7879.9 7895.4 7897.8 7952.1 829.8 841.3 893.5 905.5 1035.4 25825.5 26066.0 26082.5 29297.9 30877.8 888.8 897.8 915.8 915.9 922.3 13119.8 13585.4 13694.6 13809.6 13811.2 345323.0 351956.0 352456.0 352609.0 353410.0 44943.8 45932.5 47265.8 47648.8 47724.5 1161.1 1220.5 1226.1 1232.5 1233.5 26399.1 26408.1 26461.6 27036.3 27124.9 35226.1 36046.5 37681.6 40536.6 41446.6 176278.0 176555.0 177601.0 177652.0 178025.0 27264.3 27476.9 27602.9 27604.6 27612.4 34248.7 44034.6 45773.5 45998.0 46945.3 33023.3 33759.0 34292.3 34648.8 34706.8 33652.8 34019.7 34131.5 34341.3 34359.3 33565.5 34416.3 34512.7 34524.5 34535.7 28514.1 30893.2 31188.8 31194.2 31352.5 24304.4 24310.4 24526.0 24574.9 24734.4 12:35:45 INFO - 2015-11-23 12:35:45,540 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,540 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26513.08 Median:3449.66 stddev:79533.51 (2305.5%) stddev-sans-first:79732.35 12:35:45 INFO - 2015-11-23 12:35:45,541 DEBUG : BROWSER_OUTPUT: Values: 341.1 344.0 344.1 345.5 345.5 12669.0 12916.9 16079.8 16323.7 17127.8 10011.2 10205.3 10228.8 14354.5 14617.9 4462.2 4585.7 4597.4 4600.7 4603.0 3391.4 3449.4 3449.9 3450.8 4988.9 5153.1 5277.3 5284.2 5288.8 5316.0 4974.4 5044.1 5116.7 5307.5 5307.6 4781.6 4899.7 4903.3 4909.6 4909.7 11774.9 11989.6 11995.3 11999.5 16380.5 1762.9 1795.5 1852.1 1945.2 2003.9 9280.9 10009.3 10285.4 11235.4 13001.0 1755.2 1758.3 1790.5 1800.0 1812.8 52930.0 56055.7 56239.0 56413.0 57806.0 12265.5 14735.5 14824.5 15046.8 15997.0 22805.8 23305.3 23309.8 23321.0 23388.8 7475.3 7526.6 7604.0 7950.6 8016.2 5956.5 6156.0 6172.4 6200.9 6314.7 7657.7 7675.0 7685.9 7716.2 7730.8 1716.8 1740.1 2202.4 2917.7 2994.8 803.3 815.5 829.6 889.2 921.0 15979.4 16020.4 16031.3 16294.6 16351.4 806.2 837.4 851.9 853.4 858.6 7656.7 8915.7 9106.8 9210.3 9384.3 467067.0 473871.0 493170.0 498835.0 502919.0 68442.7 68498.7 70633.0 73305.0 74565.0 1023.8 1040.6 1041.7 1045.7 1047.5 14232.9 14628.0 14677.1 14774.6 14925.6 31928.5 32238.0 32446.7 32736.2 33434.0 38147.8 39577.0 39831.0 42239.8 42887.0 8607.7 8795.5 9010.6 9012.1 9017.6 15382.8 15415.8 15612.5 15875.4 15961.3 12650.4 12898.9 13210.7 13318.2 13412.7 12448.3 13279.7 13367.3 13602.5 14456.0 14117.4 14171.0 14271.6 14626.0 14765.3 8466.2 8790.3 8801.8 8823.8 9211.2 9814.5 9901.7 9933.6 10912.3 13393.8 12:35:45 INFO - 2015-11-23 12:35:45,541 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,541 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4773.51 Median:5876.46 stddev:2383.52 (40.6%) stddev-sans-first:2376.94 12:35:45 INFO - 2015-11-23 12:35:45,541 DEBUG : BROWSER_OUTPUT: Values: 1427.6 1623.4 1684.6 1700.1 1714.3 5922.6 6666.5 6879.0 6889.2 6898.6 6723.5 6816.1 6828.2 6833.4 6839.7 2078.9 2095.2 2097.6 2099.6 2100.3 1935.7 2097.8 2115.7 2117.7 2121.3 2022.8 2048.5 2058.5 2059.6 2061.1 2074.1 2077.9 2083.2 2087.0 2089.2 2063.0 2074.7 2089.1 2091.9 2098.2 5743.7 5931.4 6715.1 6745.9 6758.4 3506.5 3941.6 4083.5 4094.5 4102.2 2780.6 2781.2 2806.1 2820.7 2864.0 891.8 897.0 904.4 907.7 932.9 9002.5 9068.2 9068.8 9080.4 9109.0 3955.9 3985.5 4011.1 4026.0 4032.0 8044.8 8045.6 8080.2 8094.8 8110.4 4182.1 4183.5 4197.5 4214.0 4214.6 3799.9 3802.8 3825.1 3838.1 3844.7 3273.7 3276.2 3288.2 3296.9 3308.7 1082.4 1082.9 1088.5 1089.0 1097.7 930.6 963.2 1144.9 1158.1 1163.8 6417.2 6445.6 6450.4 6494.3 6494.4 947.0 948.1 956.4 1018.3 1031.5 4567.2 5128.2 5131.2 5133.7 5167.7 7286.3 7846.7 8054.6 8055.4 8079.0 7891.7 7899.4 7901.7 7904.7 7934.7 6257.7 6362.4 6393.4 6393.7 6409.6 6428.3 6433.3 6450.2 6451.8 6460.8 7175.1 7328.3 7334.2 7353.5 7361.3 7310.9 7467.1 7468.1 7471.1 7576.8 5723.3 5761.6 5782.7 5784.2 5805.2 6230.3 6287.5 6303.5 6308.5 6310.8 5959.5 6010.0 6034.4 6088.4 6092.4 5688.7 5882.0 5934.7 6133.2 6134.7 6082.8 6109.1 6144.9 6306.7 6323.7 5772.4 5815.9 5824.0 5825.3 5831.3 5793.6 5801.9 5862.9 5875.9 5877.0 12:35:45 INFO - 2015-11-23 12:35:45,541 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,542 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4724.98 Median:5202.43 stddev:1366.05 (26.3%) stddev-sans-first:1329.19 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: Values: 315.7 316.8 321.7 326.0 327.3 5228.4 5277.3 5353.2 5388.6 5440.3 5161.8 5302.2 5314.5 5343.1 5344.2 4182.5 4182.5 4188.2 4196.3 4230.9 3997.1 4073.0 4082.1 4188.8 4225.2 4124.5 4134.6 4152.5 4186.1 4186.6 4174.2 4176.6 4181.4 4183.9 4194.7 3720.5 3725.1 3728.1 3732.3 3734.4 5043.0 5165.9 5167.9 5169.4 5176.4 4847.9 4853.5 4855.1 4855.9 4858.5 5656.0 5667.1 5668.1 5668.6 5670.0 4062.9 4065.1 4069.8 4073.8 4076.3 5789.3 5850.6 5937.9 5946.6 5954.4 4181.3 4184.4 4194.2 4197.0 4199.4 4246.2 4253.7 4253.7 4254.9 4256.5 4802.7 4810.9 4812.3 4815.3 4817.0 5498.7 5648.0 5654.6 5657.5 5657.8 1491.0 1515.6 1515.8 1516.0 1516.4 1031.8 1038.3 1040.9 1046.6 1058.7 4967.4 4975.2 4985.2 4986.4 4990.3 5696.0 5837.4 5864.3 5867.6 5873.1 4863.9 4948.0 5010.2 5017.6 5031.0 3131.5 3181.4 3185.6 3185.7 3185.9 5577.8 5589.0 5593.2 5594.7 5603.2 5872.1 6081.8 6097.8 6117.5 6123.6 5562.9 5618.2 5621.6 5627.3 5630.3 5931.3 5940.2 5944.6 5944.6 5947.3 5672.9 5786.9 5794.7 5796.9 5810.8 5597.9 5599.3 5600.7 5601.8 5606.3 4080.2 4115.0 4119.7 4121.1 4125.3 5916.8 5920.1 5926.3 5927.0 5935.1 5530.8 5650.4 5652.2 5675.1 5675.6 5657.8 5658.5 5668.3 5671.3 5673.7 5534.1 5541.9 5544.4 5550.7 5552.4 5604.2 5721.7 5722.6 5724.1 5727.5 5571.0 5578.4 5585.1 5594.5 5611.9 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12095.13 Median:25172.95 stddev:14017.54 (55.7%) stddev-sans-first:14030.55 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: Values: 658.8 675.6 739.8 760.3 766.6 10978.2 11057.3 11061.6 11069.4 11120.4 10021.3 10480.2 11230.4 11321.2 11350.3 788.8 806.0 808.2 808.7 809.9 789.5 799.6 801.8 802.5 802.6 829.8 838.8 839.9 840.2 841.2 835.5 835.7 836.2 836.5 837.4 615.9 617.7 618.1 618.1 618.6 9994.7 10086.4 10099.8 10110.1 10123.3 8420.9 8712.3 9046.0 9701.6 9759.8 8534.0 8564.1 8637.8 8658.2 8678.9 3003.2 3042.5 3086.3 3176.7 3186.5 33761.0 34154.1 34154.8 34157.0 39116.8 8615.3 9138.2 9326.4 9440.3 9474.7 15874.0 16105.3 16133.7 16146.9 16170.8 6333.7 6335.9 6397.6 6401.2 6421.7 3231.6 3318.5 3409.3 3424.7 3765.4 2779.2 2784.0 2804.8 2810.6 2812.6 487.6 497.3 506.9 507.6 527.5 465.1 491.4 510.7 535.6 626.4 7892.3 7953.5 7978.8 8075.6 8148.4 558.2 565.8 569.4 574.9 622.5 3553.2 3566.4 3599.4 3620.1 3651.5 49839.0 50681.0 51060.7 51193.0 51218.2 45555.0 46136.3 46262.3 46385.5 46660.0 39689.6 39884.2 44435.6 46308.5 46956.5 8132.6 8242.3 8491.0 8592.4 8596.4 31290.5 31824.0 32385.8 32417.0 32958.0 35910.3 36220.3 40790.4 44298.0 44468.8 9877.8 9890.2 9898.0 10039.6 10336.2 10438.8 10473.8 10639.5 10647.6 11049.4 10414.6 10466.5 10474.9 10497.5 10504.8 10573.6 10724.8 10752.5 10849.1 10869.3 10068.2 10215.2 10224.3 10258.9 10599.2 9056.9 9110.0 9369.0 9417.5 9448.4 8801.9 8904.7 8910.5 8946.0 9213.4 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:45 INFO - 2015-11-23 12:35:45,543 DEBUG : BROWSER_OUTPUT: 12:35:46 INFO - 2015-11-23 12:35:46,331 INFO : Browser exited with error code: 0 12:35:46 INFO - 2015-11-23 12:35:46,350 INFO : Completed test dromaeo_css (00:18:38) 12:35:46 INFO - 2015-11-23 12:35:46,350 INFO : Starting test kraken 12:35:46 INFO - 2015-11-23 12:35:46,350 DEBUG : operating with platform_type : linux_ 12:35:46 INFO - 2015-11-23 12:35:46,350 INFO : Initialising browser for kraken test... 12:35:46 INFO - 2015-11-23 12:35:46,356 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKpNNiM/profile http://localhost:40995/getInfo.html 12:35:50 INFO - 2015-11-23 12:35:50,512 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:50 INFO - 2015-11-23 12:35:50,513 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:50 INFO - 2015-11-23 12:35:50,513 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:35:50 INFO - 2015-11-23 12:35:50,513 DEBUG : BROWSER_OUTPUT: __metrics 12:35:50 INFO - 2015-11-23 12:35:50,634 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:51 INFO - 2015-11-23 12:35:51,926 INFO : Browser initialized. 12:35:51 INFO - 2015-11-23 12:35:51,926 INFO : Running cycle 1/1 for kraken test... 12:35:51 INFO - 2015-11-23 12:35:51,927 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKpNNiM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:03 INFO - 2015-11-23 12:36:03,824 DEBUG : BROWSER_OUTPUT: RSS: Main: 140173312 12:36:03 INFO - 2015-11-23 12:36:03,825 DEBUG : BROWSER_OUTPUT: 12:36:06 INFO - 2015-11-23 12:36:06,423 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:40995/tests/kraken/driver.html?testName=audio-beat-detection) 12:36:07 INFO - 2015-11-23 12:36:07,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 179453952 12:36:07 INFO - 2015-11-23 12:36:07,008 DEBUG : BROWSER_OUTPUT: 12:36:09 INFO - 2015-11-23 12:36:09,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:40995/tests/kraken/driver.html?testName=audio-dft) 12:36:10 INFO - 2015-11-23 12:36:10,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 168607744 12:36:10 INFO - 2015-11-23 12:36:10,299 DEBUG : BROWSER_OUTPUT: 12:36:13 INFO - 2015-11-23 12:36:13,278 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:40995/tests/kraken/driver.html?testName=audio-fft) 12:36:13 INFO - 2015-11-23 12:36:13,840 DEBUG : BROWSER_OUTPUT: RSS: Main: 152678400 12:36:13 INFO - 2015-11-23 12:36:13,840 DEBUG : BROWSER_OUTPUT: 12:36:15 INFO - 2015-11-23 12:36:15,878 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:40995/tests/kraken/driver.html?testName=audio-oscillator) 12:36:16 INFO - 2015-11-23 12:36:16,452 DEBUG : BROWSER_OUTPUT: RSS: Main: 155176960 12:36:16 INFO - 2015-11-23 12:36:16,452 DEBUG : BROWSER_OUTPUT: 12:36:18 INFO - 2015-11-23 12:36:18,646 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:40995/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:36:19 INFO - 2015-11-23 12:36:19,219 DEBUG : BROWSER_OUTPUT: RSS: Main: 155414528 12:36:19 INFO - 2015-11-23 12:36:19,219 DEBUG : BROWSER_OUTPUT: 12:36:22 INFO - 2015-11-23 12:36:22,176 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:40995/tests/kraken/driver.html?testName=imaging-darkroom) 12:36:22 INFO - 2015-11-23 12:36:22,744 DEBUG : BROWSER_OUTPUT: RSS: Main: 156393472 12:36:22 INFO - 2015-11-23 12:36:22,744 DEBUG : BROWSER_OUTPUT: 12:36:26 INFO - 2015-11-23 12:36:26,218 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:40995/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:26 INFO - 2015-11-23 12:36:26,801 DEBUG : BROWSER_OUTPUT: RSS: Main: 156798976 12:36:26 INFO - 2015-11-23 12:36:26,801 DEBUG : BROWSER_OUTPUT: 12:36:29 INFO - 2015-11-23 12:36:29,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:40995/tests/kraken/driver.html?testName=json-parse-financial) 12:36:30 INFO - 2015-11-23 12:36:30,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 156643328 12:36:30 INFO - 2015-11-23 12:36:30,185 DEBUG : BROWSER_OUTPUT: 12:36:31 INFO - 2015-11-23 12:36:31,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:40995/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:32 INFO - 2015-11-23 12:36:32,501 DEBUG : BROWSER_OUTPUT: RSS: Main: 167976960 12:36:32 INFO - 2015-11-23 12:36:32,501 DEBUG : BROWSER_OUTPUT: 12:36:34 INFO - 2015-11-23 12:36:34,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:34 INFO - 2015-11-23 12:36:34,978 DEBUG : BROWSER_OUTPUT: RSS: Main: 166748160 12:36:34 INFO - 2015-11-23 12:36:34,978 DEBUG : BROWSER_OUTPUT: 12:36:37 INFO - 2015-11-23 12:36:37,090 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:37 INFO - 2015-11-23 12:36:37,670 DEBUG : BROWSER_OUTPUT: RSS: Main: 171503616 12:36:37 INFO - 2015-11-23 12:36:37,671 DEBUG : BROWSER_OUTPUT: 12:36:40 INFO - 2015-11-23 12:36:40,170 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:40 INFO - 2015-11-23 12:36:40,754 DEBUG : BROWSER_OUTPUT: RSS: Main: 180215808 12:36:40 INFO - 2015-11-23 12:36:40,755 DEBUG : BROWSER_OUTPUT: 12:36:43 INFO - 2015-11-23 12:36:43,338 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:43 INFO - 2015-11-23 12:36:43,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 177766400 12:36:43 INFO - 2015-11-23 12:36:43,919 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,669 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:40995/tests/kraken/driver.html?testName=ai-astar) 12:36:45 INFO - 2015-11-23 12:36:45,919 DEBUG : BROWSER_OUTPUT: RSS: Main: 237142016 12:36:45 INFO - 2015-11-23 12:36:45,919 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;106;114;115;113;102;112;115;114 12:36:45 INFO - 2015-11-23 12:36:45,920 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;154;134;161;173;129;160;148;129;176;128 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;161;160;160;161;161;159;162;162;163 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;83;92;75;74;72;120;95;73 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;124;90;91;90;131;91;91;125 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;109;109;109;109;109;109;109 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;145;146;147;146;147;147;146;146 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;96;95;95 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;69;71;69;69;70;70;70;70;69 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;68;69;69;69;68;67;69;68 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;80;82;85;83;90;82;83;84;84;86 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;118;127;120;130;126;129;125;121;125 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;137;137;148;152;153;135;148;148;145;133 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;71;68;69;68;68;68;67;70;68 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,983 12:36:45 INFO - 2015-11-23 12:36:45,921 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:45 INFO - 2015-11-23 12:36:45,922 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311005919__endTimestamp 12:36:45 INFO - 2015-11-23 12:36:45,922 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:111.50 Median:113.50 stddev:4.25 (3.7%) stddev-sans-first:4.50 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 106.0 114.0 115.0 113.0 102.0 112.0 115.0 114.0 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,925 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.20 Median:157.00 stddev:18.44 (11.7%) stddev-sans-first:19.48 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: Values: 154.0 134.0 161.0 173.0 129.0 160.0 148.0 129.0 176.0 128.0 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.00 Median:161.00 stddev:1.15 (0.7%) stddev-sans-first:1.22 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: Values: 161.0 161.0 160.0 160.0 161.0 161.0 159.0 162.0 162.0 163.0 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.10 Median:74.50 stddev:15.42 (20.7%) stddev-sans-first:15.92 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 83.0 92.0 75.0 74.0 72.0 120.0 95.0 73.0 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.50 Median:91.00 stddev:17.46 (19.2%) stddev-sans-first:18.10 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 124.0 90.0 91.0 90.0 131.0 91.0 91.0 125.0 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.10 Median:109.00 stddev:0.32 (0.3%) stddev-sans-first:0.00 12:36:45 INFO - 2015-11-23 12:36:45,926 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 109.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:147.00 stddev:0.70 (0.5%) stddev-sans-first:0.71 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 145.0 146.0 147.0 146.0 147.0 147.0 146.0 146.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.20 Median:95.00 stddev:0.42 (0.4%) stddev-sans-first:0.33 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.60 Median:70.00 stddev:0.70 (1.0%) stddev-sans-first:0.71 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 71.0 69.0 69.0 70.0 70.0 70.0 70.0 69.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.20 Median:68.50 stddev:0.79 (1.2%) stddev-sans-first:0.83 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 68.0 69.0 69.0 69.0 68.0 67.0 69.0 68.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:2.73 (3.2%) stddev-sans-first:2.50 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: Values: 80.0 82.0 85.0 83.0 90.0 82.0 83.0 84.0 84.0 86.0 12:36:45 INFO - 2015-11-23 12:36:45,927 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:125.00 Median:126.50 stddev:4.11 (3.2%) stddev-sans-first:4.10 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: Values: 129.0 118.0 127.0 120.0 130.0 126.0 129.0 125.0 121.0 125.0 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.60 Median:148.00 stddev:7.40 (5.0%) stddev-sans-first:7.45 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: Values: 137.0 137.0 148.0 152.0 153.0 135.0 148.0 148.0 145.0 133.0 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.00 stddev:1.18 (1.7%) stddev-sans-first:1.24 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: Values: 68.0 71.0 68.0 69.0 68.0 68.0 68.0 67.0 70.0 68.0 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:45 INFO - 2015-11-23 12:36:45,928 DEBUG : BROWSER_OUTPUT: 12:36:46 INFO - 2015-11-23 12:36:46,819 INFO : Browser exited with error code: 0 12:36:46 INFO - 2015-11-23 12:36:46,872 INFO : Completed test kraken (00:01:00) 12:36:46 INFO - 2015-11-23 12:36:46,872 INFO : Starting test v8_7 12:36:46 INFO - 2015-11-23 12:36:46,872 DEBUG : operating with platform_type : linux_ 12:36:46 INFO - 2015-11-23 12:36:46,872 INFO : Initialising browser for v8_7 test... 12:36:46 INFO - 2015-11-23 12:36:46,878 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWNGiEz/profile http://localhost:40995/getInfo.html 12:36:51 INFO - 2015-11-23 12:36:51,065 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:51 INFO - 2015-11-23 12:36:51,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:51 INFO - 2015-11-23 12:36:51,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:51 INFO - 2015-11-23 12:36:51,065 DEBUG : BROWSER_OUTPUT: __metrics 12:36:51 INFO - 2015-11-23 12:36:51,222 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:36:52 INFO - 2015-11-23 12:36:52,448 INFO : Browser initialized. 12:36:52 INFO - 2015-11-23 12:36:52,449 INFO : Running cycle 1/1 for v8_7 test... 12:36:52 INFO - 2015-11-23 12:36:52,449 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpWNGiEz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:04 INFO - 2015-11-23 12:37:04,266 DEBUG : BROWSER_OUTPUT: RSS: Main: 141434880 12:37:04 INFO - 2015-11-23 12:37:04,266 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:40995/tests/v8_7/run.html (next: http://localhost:40995/tests/v8_7/run.html) 12:37:25 INFO - 2015-11-23 12:37:25,965 DEBUG : BROWSER_OUTPUT: RSS: Main: 440160256 12:37:25 INFO - 2015-11-23 12:37:25,965 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5858007524947 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;186.42803877703207 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.8988764044944 12:37:25 INFO - 2015-11-23 12:37:25,966 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5112.244897959184 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2014.0845070422536 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |5;Earley;781.8608287724785 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |6;Boyer;12231.707317073171 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |7;RegExp;26394.736842105263 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |8;Splay;600.3573555687909 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311045964__endTimestamp 12:37:25 INFO - 2015-11-23 12:37:25,967 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.59 Median:163.59 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: Values: 163.6 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,968 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:186.43 Median:186.43 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,969 DEBUG : BROWSER_OUTPUT: Values: 186.4 12:37:25 INFO - 2015-11-23 12:37:25,969 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,969 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.90 Median:280.90 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: Values: 280.9 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5112.24 Median:5112.24 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: Values: 5112.2 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2014.08 Median:2014.08 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: Values: 2014.1 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:781.86 Median:781.86 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: Values: 781.9 12:37:25 INFO - 2015-11-23 12:37:25,970 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12231.71 Median:12231.71 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: Values: 12231.7 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26394.74 Median:26394.74 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: Values: 26394.7 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:600.36 Median:600.36 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,971 DEBUG : BROWSER_OUTPUT: Values: 600.4 12:37:25 INFO - 2015-11-23 12:37:25,972 DEBUG : BROWSER_OUTPUT: 12:37:25 INFO - 2015-11-23 12:37:25,972 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 12:37:25 INFO - 2015-11-23 12:37:25,972 DEBUG : BROWSER_OUTPUT: Values: 4835.7 12:37:25 INFO - 2015-11-23 12:37:25,972 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:25 INFO - 2015-11-23 12:37:25,972 DEBUG : BROWSER_OUTPUT: 12:37:26 INFO - 2015-11-23 12:37:26,919 INFO : Browser exited with error code: 0 12:37:26 INFO - 2015-11-23 12:37:26,931 INFO : Completed test v8_7 (00:00:40) 12:37:26 INFO - 2015-11-23 12:37:26,934 INFO : Completed test suite (00:20:19) 12:37:26 INFO - 2015-11-23 12:37:26,934 DEBUG : Working with test: dromaeo_css 12:37:26 INFO - 2015-11-23 12:37:26,934 DEBUG : Generating results file: dromaeo_css 12:37:26 INFO - 2015-11-23 12:37:26,935 DEBUG : Working with test: kraken 12:37:26 INFO - 2015-11-23 12:37:26,935 DEBUG : Generating results file: kraken 12:37:26 INFO - 2015-11-23 12:37:26,935 INFO : javascript benchmark 12:37:26 INFO - 2015-11-23 12:37:26,935 DEBUG : Working with test: v8_7 12:37:26 INFO - 2015-11-23 12:37:26,935 DEBUG : Generating results file: v8_7 12:37:26 INFO - 2015-11-23 12:37:26,935 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:26 INFO - 2015-11-23 12:37:26,984 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:37:26 INFO - 2015-11-23 12:37:26,984 DEBUG : process_Request line: dromaeo_css 6338.80 graph.html#tests=[[72,132,35]] 12:37:26 INFO - 2015-11-23 12:37:26,984 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:27 INFO - 2015-11-23 12:37:27,022 DEBUG : process_Request line: kraken 1515.80 graph.html#tests=[[232,132,35]] 12:37:27 INFO - 2015-11-23 12:37:27,022 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:27 INFO - 2015-11-23 12:37:27,059 DEBUG : process_Request line: v8_7 19877.20 graph.html#tests=[[230,132,35]] 12:37:27 INFO - 2015-11-23 12:37:27,061 INFO : javascript benchmark 12:37:27 INFO - 2015-11-23 12:37:27,064 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2640.84154950703, 2719.456108778245, 2721.0680416903997, 2735.411886444414, 2740.177946616016, 4508.053308805147, 4629.189891768944, 4638.0, 4712.98670785781, 4718.858434246969, 4524.3213517972235, 4593.242115051013, 4604.631629469643, 4614.630829533638, 4617.2150734375155, 4318.114786468782, 4336.154449882274, 4337.609615134637, 4368.934465983013, 4374.518802931675, 4161.729487583312, 4362.214801335758, 4373.781310934456, 4427.579379958899, 4456.3315502674695, 4267.8079486423185, 4284.807183676711, 4335.7181783184, 4338.674599405026, 4368.4102646143, 4356.455443069616, 4401.22978478765, 4406.25093734066, 4410.735355878657, 4455.799489023002, 4106.733062350938, 4386.254336762758, 4390.912181756379, 4419.53594872537, 4441.089576636814, 4490.910181796378, 4538.228501154778, 4619.676622636417, 4733.219018861883, 4766.046790641885, 4997.225430058346, 5023.874403139914, 5024.547790698818, 5032.245163225509, 5066.82266120684, 4699.835505757316, 5068.366454193226, 5070.163423035195, 5072.644914855961, 5073.188289873639, 4625.098105869391, 4639.791209395586, 4653.650976176733, 4726.125666751662, 4791.760411979387, 5170.844874653766, 5171.0, 5171.2501687255135, 5174.508421700008, 5228.92156617651, 4738.3129446230105, 4977.0792403405485, 4978.0, 4979.327790748275, 5029.698218106925, 4907.558319751168, 4920.852374428773, 4928.802847886116, 5018.924716129261, 5041.79832806691, 4970.478099799541, 4971.130052240844, 4971.477994810565, 4972.030454061495, 5021.899562008813, 4721.811127554859, 4941.283513890466, 4945.184044632595, 4950.331705219749, 4997.85006449807, 4112.650424713933, 4132.173565286955, 4140.047789008485, 4169.145325208325, 4193.475815523059, 3670.064133645903, 3685.0418891087975, 3688.55737311519, 3693.169036966661, 3710.888673339804, 4355.673324500612, 4364.476262848479, 4369.628581570539, 4370.737755734666, 4407.823687052482, 4838.104950584153, 4953.554180123734, 4964.180910149785, 5005.1491246488185, 5014.272930425068, 4395.7142785718825, 4404.933925991113, 4410.647148228134, 4435.889102772457, 4450.332450132506, 4534.478534968521, 4540.523245059288, 4545.0, 4555.703879247838, 4582.450105987303, 4577.793999269974, 4682.765861706833, 4683.227267500824, 4684.50812664679, 4870.8782280442565, 4917.409910810583, 4975.253711943237, 4992.500749924979, 4997.625178111583, 5040.84877453677, 4827.396575428072, 4829.203181475017, 4831.661783675109, 4837.806487740591, 4873.269009648581, 4755.809767609257, 4863.537963893425, 5025.0, 5032.924506132338, 5072.644914855925, 4906.705597664151, 4985.850424487271, 5068.2904393384215, 5076.162433198481, 5119.180931051163, 4868.951310486991, 4879.609631229564, 4882.267659851051, 4884.218525035977, 4929.260610908393, 4573.359729637787, 4697.201475749199, 4888.58447031992, 4889.535494128052, 4927.088488629615, 4683.297505374221, 4759.0, 4806.182948898766, 4811.037792441456, 4868.732219727949, 4945.282933974481, 4966.205407134841, 4971.975140124277, 4979.502049794992, 4982.177940639754, 4534.410526631649, 4623.190941585276, 4879.609631229422, 4880.755962201947, 4918.016396720742], "unit": "ms", "name": "dojo.html", "value": 4604.808148136214}, {"lowerIsBetter": false, "replicates": [559.3958524793222, 569.7863301262026, 576.9931469585574, 580.2543731305273, 582.9300483941928, 27608.17175484736, 35741.82129089354, 36905.0, 36920.0, 36948.63051369486, 39701.20597588047, 40333.0, 40418.59581404185, 40428.19143617126, 40440.191196176056, 6977.511574189809, 7102.822429439254, 7650.120236172828, 8098.919010809905, 8107.797305067362, 10158.74603134924, 10346.741331466697, 10371.688849334494, 10417.062464378205, 10421.531031103581, 10127.49362531874, 10235.130013948823, 10238.692839214835, 10243.795124097514, 10246.89753102467, 7117.3238542338395, 7290.74482393119, 7303.196648368676, 7312.37844783194, 10044.54799534019, 7009.929900700979, 10273.589056437733, 10476.52855621499, 10490.790184196274, 10532.473376331152, 36986.26027479435, 37220.25559488822, 37409.25181496355, 37425.0, 37520.81239593812, 2948.3808400235976, 3015.9698403016127, 3024.833634150121, 3518.3315170117853, 3666.211764470652, 24039.87980060106, 28448.0, 28656.856715716498, 29207.56188657172, 29701.405971880657, 3369.578802649669, 3451.8274086295837, 3455.7580969332157, 3577.266660334625, 3601.927961440783, 238168.0, 240910.0, 241896.0, 242353.0, 242505.7874710633, 52372.738136309075, 53460.73269633627, 57805.0, 58269.70865145647, 58396.416035839095, 66606.33393666001, 68220.6588967052, 68458.31541684619, 68507.3149268501, 68531.65734171297, 12585.874141258653, 12818.871811281955, 12824.422900969479, 12825.29460879642, 12829.10196286251, 9307.11582399671, 9337.439753614804, 9363.672271470467, 9375.203107735919, 9398.718038458721, 19347.0, 19726.153400086845, 19758.40724778259, 19776.70334944977, 19820.40538783839, 7779.338756205672, 7879.921200788033, 7895.44704882805, 7897.763067107996, 7952.085510166289, 829.8340331933516, 841.3059226138461, 893.4862454088925, 905.4702998745676, 1035.404642330663, 25825.483490330087, 26066.0, 26082.478350432884, 29297.85351073231, 30877.78353184848, 888.8000199955088, 897.7531178925848, 915.8203475727726, 915.8580420034905, 922.285228947571, 13119.803202951964, 13585.388657510435, 13694.589162325146, 13809.585712428643, 13811.240381779098, 345323.0, 351956.0, 352456.0, 352609.0, 353410.0, 44943.77528112339, 45932.54067459283, 47265.76367118143, 47648.761756190994, 47724.522754772705, 1161.0653423993597, 1220.5178954313174, 1226.1171956191529, 1232.4577186038293, 1233.543588872123, 26399.076032338777, 26408.075717349802, 26461.603075954263, 27036.32409189786, 27124.864375677997, 35226.119347015505, 36046.45930310995, 37681.623183768905, 40536.59463405328, 41446.58553414427, 176278.0, 176555.0, 177601.0, 177652.0, 178025.0, 27264.318392039564, 27476.862615686794, 27602.861985689942, 27604.585931211448, 27612.447751045267, 34248.65751342455, 44034.55965440305, 45773.54226457693, 45998.0, 46945.29582056204, 33023.339533209684, 33759.0, 34292.31415371629, 34648.82675586606, 34706.82646586751, 33652.83173584214, 34019.65980340165, 34131.48802767911, 34341.31317373688, 34359.31281374308, 33565.496517551765, 34416.31167376688, 34512.65487345094, 34524.48213276752, 34535.65464345425, 28514.14457566276, 30893.227669308446, 31188.844055779577, 31194.181106568147, 31352.52971205388, 24304.392390190387, 24310.392240194138, 24526.0, 24574.877125614257, 24734.38164045913], "unit": "ms", "name": "ext.html", "value": 17328.123430132608}, {"lowerIsBetter": false, "replicates": [341.12501433822257, 343.9982800085999, 344.1224876564759, 345.47315344100247, 345.5438820756602, 12669.0, 12916.870831291684, 16079.75880361794, 16323.673526529463, 17127.828721712795, 10011.197984362812, 10205.336653117542, 10228.846567301496, 14354.497592584261, 14617.853821461782, 4462.1521910837, 4585.701929374597, 4597.37935378723, 4600.746958917258, 4602.987342784599, 3391.3725960697225, 3449.4480883058714, 3449.862005519776, 3450.7756995795316, 4988.900221995558, 5153.072446959546, 5277.261183434322, 5284.207368894658, 5288.8413347599635, 5315.973420132913, 4974.403071631409, 5044.142495775727, 5116.667416617908, 5307.495787900143, 5307.575393968474, 4781.569658730731, 4899.681520701143, 4903.2645103234445, 4909.6072314215135, 4909.68087074339, 11774.882251177463, 11989.580364687194, 11995.280283183038, 11999.46002429884, 16380.508584742358, 1762.903040332794, 1795.4523870219577, 1852.1480119145074, 1945.2121890634317, 2003.8697484663596, 9280.860787088199, 10009.29934904557, 10285.382877027403, 11235.382053987027, 13001.0, 1755.2452445448453, 1758.2878934031737, 1790.534461040126, 1800.0369802155915, 1812.8459080978132, 52930.0, 56055.71972140154, 56239.0, 56413.0, 57805.99999999958, 12265.466816647919, 14735.484258050918, 14824.481143160154, 15046.774298385533, 15997.0, 22805.771942280364, 23305.300840974796, 23309.785570370786, 23320.950557224965, 23388.76611233866, 7475.289847464483, 7526.623668816537, 7604.049493813273, 7950.6422211000645, 8016.198380161937, 5956.463918247292, 6156.0458128989185, 6172.351903050115, 6200.937990620036, 6314.71583778731, 7657.731979380695, 7674.96162519195, 7685.923140768633, 7716.151223365426, 7730.7680769577, 1716.828317168273, 1740.1212387744108, 2202.361315218601, 2917.693642167584, 2994.77539184562, 803.2730379007008, 815.5432957543794, 829.5520418973807, 889.1775108025051, 920.9593159729596, 15979.440719574759, 16020.439284624983, 16031.278592463133, 16294.592635184215, 16351.427700030441, 806.1978331560135, 837.405442136078, 851.8594431918788, 853.3514528958036, 858.6050416808213, 7656.693732250759, 8915.687950921687, 9106.81786364269, 9210.309226808016, 9384.343095983351, 467067.0, 473871.0, 493170.0, 498835.0, 502919.0, 68442.65778671174, 68498.65750671214, 70633.0, 73305.0, 74565.0, 1023.8157131716363, 1040.557762950743, 1041.7083216699489, 1045.6810672744887, 1047.4919663962971, 14232.857671423568, 14628.0, 14677.119372837664, 14774.63063423423, 14925.626859328604, 31928.52107218347, 32238.0, 32446.67553324531, 32736.181595460304, 33434.0, 38147.809260953516, 39577.0, 39831.0, 42239.788801055794, 42887.0, 8607.741767746978, 8795.516246606498, 9010.594523246338, 9012.098790120936, 9017.594208260512, 15382.846171538142, 15415.76876346878, 15612.4535641252, 15875.444359447363, 15961.281742321855, 12650.43073061696, 12898.935505322788, 13210.688129577093, 13318.200907945555, 13412.731745364843, 12448.31534265624, 13279.66800829987, 13367.331633418486, 13602.455901763818, 14456.0, 14117.43530258778, 14171.0, 14271.64320891986, 14626.0, 14765.261736913326, 8466.238038576557, 8790.252828509392, 8801.823963520821, 8823.823523529622, 9211.170994610517, 9814.509274536387, 9901.702948911545, 9933.552990115606, 10912.290701104403, 13393.799093013418], "unit": "ms", "name": "jquery.html", "value": 8463.759308167253}, {"lowerIsBetter": false, "replicates": [1427.6002719238618, 1623.3587732845524, 1684.5788552861784, 1700.0734599643192, 1714.331410749808, 5922.555808314378, 6666.500012499064, 6879.0, 6889.242183359826, 6898.551594146377, 6723.4957378196705, 6816.079829223054, 6828.2488926218075, 6833.350831670996, 6839.726410943569, 2078.896055197242, 2095.224766836273, 2097.590969760897, 2099.6010757956014, 2100.2544096845554, 1935.680612698903, 2097.797312821539, 2115.7249557557498, 2117.692934524493, 2121.2681624839406, 2022.8482863785275, 2048.5288383671764, 2058.53682921343, 2059.6189704904564, 2061.124022290528, 2074.1392322186275, 2077.9376618701463, 2083.2083808152806, 2087.0191010225244, 2089.1747759634936, 2063.030375723408, 2074.6887966804948, 2089.101686274901, 2091.874487530753, 2098.150249149097, 5743.684097374643, 5931.377205393414, 6715.059891615178, 6745.865082698368, 6758.425533829631, 3506.491558723996, 3941.5861334559745, 4083.4691490106393, 4094.508658960914, 4102.159057393227, 2780.555111182201, 2781.193453898367, 2806.1020473448507, 2820.675622303441, 2863.954656550365, 891.7503099132254, 896.9820603587891, 904.4166512599337, 907.7458311672676, 932.9486878221695, 9002.549872506348, 9068.183863452256, 9068.773280668036, 9080.40977336471, 9109.043550427243, 3955.9011024724614, 3985.501812273466, 4011.0774521860135, 4026.0, 4031.9798401007806, 8044.758657240292, 8045.597720113971, 8080.232377924088, 8094.757157285291, 8110.391720620977, 4182.100848317566, 4183.5398106208295, 4197.496300443905, 4214.030772922184, 4214.620684138442, 3799.886003419902, 3802.7908465034134, 3825.081980324702, 3838.0788610733225, 3844.6732027777393, 3273.7217336526187, 3276.1973316537124, 3288.1615188126875, 3296.8681252750102, 3308.6525914778604, 1082.3938594387168, 1082.8592283003318, 1088.450332582041, 1088.9945550272198, 1097.742030622803, 930.6417029443578, 963.1909196275162, 1144.9484773185227, 1158.1314014489133, 1163.8254261860789, 6417.2299324081405, 6445.581037232565, 6450.354964503512, 6494.253160886558, 6494.383033611799, 947.0, 948.1324588002038, 956.3879117364892, 1018.2973748113777, 1031.4687935713114, 4567.155076310827, 5128.153854614022, 5131.2046632771235, 5133.666311689728, 5167.715775632376, 7286.307800759026, 7846.686132554748, 8054.5569993650915, 8055.436119471581, 8079.03051633796, 7891.723789667449, 7899.447038707351, 7901.723439679584, 7904.6838126474295, 7934.722284720007, 6257.749690012349, 6362.363763623601, 6393.392627700361, 6393.712282947278, 6409.583377080568, 6428.292887782433, 6433.324500927335, 6450.193725784277, 6451.774187903401, 6460.773872914613, 7175.138983322035, 7328.267173282629, 7334.193238743841, 7353.522021068614, 7361.2638736125955, 7310.890336645061, 7467.1039475263315, 7468.103827540513, 7471.103467583925, 7576.772696819105, 5723.313202415737, 5761.625494342854, 5782.739776710142, 5784.161296611884, 5805.158252053513, 6230.283517395376, 6287.528435367457, 6303.46420554258, 6308.495320374451, 6310.842228944313, 5959.463648271676, 6010.0, 6034.426729460694, 6088.391160883876, 6092.390760923872, 5688.7440065198, 5882.029465138205, 5934.673592952429, 6133.202683651097, 6134.693265336805, 6082.787102451393, 6109.144719739151, 6144.8771024580155, 6306.716197771203, 6323.715432805627, 5772.422757724362, 5815.883682326245, 5824.039033559416, 5825.330087040044, 5831.329397119385, 5793.565482588739, 5801.941980580309, 5862.853428664317, 5875.9423303805725, 5876.970615146897], "unit": "ms", "name": "mootools.html", "value": 3982.2634919618185}, {"lowerIsBetter": false, "replicates": [315.66066478535566, 316.78616933569845, 321.69599728256793, 325.9967400325996, 327.31427659054305, 5228.424873263947, 5277.287566178565, 5353.197020446935, 5388.568914486841, 5440.319960004995, 5161.767720452579, 5302.204669299607, 5314.495122963322, 5343.145096784515, 5344.198370244465, 4182.477190351206, 4182.498100227962, 4188.204241194178, 4196.328587426013, 4230.91538169238, 3997.1406147678244, 4073.0, 4082.0815316553835, 4188.81150348235, 4225.218334608092, 4124.525679546846, 4134.607212314825, 4152.460180176573, 4186.079062606237, 4186.644135248507, 4174.248635245639, 4176.561461046576, 4181.414601955728, 4183.916321673565, 4194.727342722713, 3720.4605332226674, 3725.050112221393, 3728.1425272187275, 3732.2722069196516, 3734.3651579231596, 5043.0, 5165.896682066337, 5167.948320516784, 5169.353830771153, 5176.430592634807, 4847.903041939141, 4853.538913803183, 4855.101806165871, 4855.902881942377, 4858.5384388483035, 5656.0, 5667.149927510865, 5668.064769313059, 5668.57485688575, 5670.0, 4062.8577999770164, 4065.125997910434, 4069.7558146511305, 4073.775942323171, 4076.30702780528, 5789.305283365981, 5850.5612079094235, 5937.851553711149, 5946.554008449383, 5954.374790647006, 4181.289180839264, 4184.4351012613515, 4194.203101410722, 4196.958030419718, 4199.4120823084795, 4246.193223287565, 4253.659707223414, 4253.659707223414, 4254.915091605091, 4256.510501292391, 4802.73584952824, 4810.927836082462, 4812.326274321597, 4815.3017812417, 4817.012512434942, 5498.697571633518, 5648.0, 5654.6324488908085, 5657.4908258256955, 5657.773689052474, 1490.970180596382, 1515.6210947263185, 1515.8332583415815, 1516.0145905161733, 1516.385863725193, 1031.7936412717336, 1038.2576457832686, 1040.9063184313447, 1046.602291129366, 1058.7035630023606, 4967.403911530567, 4975.154223781966, 4985.152524070917, 4986.376702912136, 4990.30135780991, 5695.971520142456, 5837.445442682938, 5864.325602555676, 5867.647941123546, 5873.119032145212, 4863.927041094386, 4948.0, 5010.248462730619, 5017.623678224148, 5031.0441016206805, 3131.498960166408, 3181.44324743169, 3185.601799775028, 3185.7132858042423, 3185.9203519911725, 5577.776888924398, 5588.9720551397795, 5593.244911936918, 5594.748236329375, 5603.159526071122, 5872.148538461899, 6081.787137450168, 6097.817065488042, 6117.480014198843, 6123.632582045091, 5562.916556251659, 5618.185363122325, 5621.634593751393, 5627.32472103342, 5630.296212973379, 5931.258592675916, 5940.1683764272175, 5944.613600115978, 5944.613600115978, 5947.256592925884, 5672.858178545569, 5786.9131963019745, 5794.710264486843, 5796.8550786229, 5810.82567522975, 5597.944020559742, 5599.272094627672, 5600.691961942132, 5601.831945041656, 5606.271184745957, 4080.2451546464, 4114.958850411457, 4119.670426365943, 4121.093359460914, 4125.339945608688, 5916.763329466945, 5920.082387229986, 5926.348101708722, 5927.0220413633, 5935.139404786368, 5530.778768849362, 5650.434956504317, 5652.180433836988, 5675.148727690879, 5675.574331925205, 5657.773689052557, 5658.462446067617, 5668.26312579362, 5671.262735844314, 5673.716314184357, 5534.05920993424, 5541.861453463534, 5544.41783612731, 5550.666959982414, 5552.416996215339, 5604.187392828098, 5721.742521586455, 5722.599418040697, 5724.084146536534, 5727.455891690282, 5570.972145139248, 5578.414266502121, 5585.050541407889, 5594.468525490072, 5611.915821262766], "unit": "ms", "name": "prototype.html", "value": 4293.66647301845}, {"lowerIsBetter": false, "replicates": [658.7694306992552, 675.614899507281, 739.8483310921262, 760.3043215457857, 766.6320166320166, 10978.231523793327, 11057.281276717007, 11061.557537698493, 11069.391183484906, 11120.388378639193, 10021.34861234021, 10480.161587073035, 11230.438478076105, 11321.150913681466, 11350.318980861133, 788.8185717285043, 805.963731632075, 808.1595141053298, 808.6563210635456, 809.8866158737782, 789.5381201996839, 799.6401619271351, 801.7755028592004, 802.4984384759525, 802.638812534359, 829.8298848735994, 838.7609531283586, 839.8530257204995, 840.1514470384894, 841.154639587217, 835.5028757889046, 835.7409203147014, 836.1513064239801, 836.4646626159263, 837.3803385494751, 615.8799034188335, 617.7220250887119, 618.0667192539298, 618.0975775367968, 618.5700937848197, 9994.700158995242, 10086.445245511493, 10099.848502272473, 10110.140638045776, 10123.29136960413, 8420.915790842075, 8712.346574006975, 9045.954770226173, 9701.563429645683, 9759.804803903953, 8533.957330213372, 8564.057953625097, 8637.784055398603, 8658.220760131555, 8678.86981695275, 3003.189138932476, 3042.4675681755602, 3086.2901532647616, 3176.65056843747, 3186.5379519969706, 33761.0, 34154.14614634629, 34154.779939303866, 34157.0, 39116.804415978026, 8615.332607517666, 9138.223251023737, 9326.393784404128, 9440.29197810167, 9474.715758527118, 15874.0, 16105.27526261321, 16133.67732645364, 16146.919265403598, 16170.75743863843, 6333.65164915934, 6335.873282534323, 6397.61614303134, 6401.231852177675, 6421.711023003976, 3231.5960504936884, 3318.4856347266214, 3409.2670075933793, 3424.6575342466053, 3765.3975363941636, 2779.1801418581567, 2783.9860800695865, 2804.845733484678, 2810.57841323799, 2812.5640525718545, 487.5563237453971, 497.2615665736379, 506.90115427491287, 507.6091409614576, 527.4751622135999, 465.12556393979105, 491.42748697767416, 510.6757209172128, 535.635767677975, 626.3517259636254, 7892.329152022143, 7953.483023603563, 7978.840423191504, 8075.555844428495, 8148.388870834592, 558.1711158928987, 565.7961347190414, 569.4334137533181, 574.8562859285179, 622.5082185073832, 3553.1650062235353, 3566.4293713005795, 3599.352116618981, 3620.149264922741, 3651.5253017107607, 49839.0, 50681.0, 51060.744696276284, 51193.0, 51218.23172652413, 45555.0, 46136.3079553807, 46262.306065409044, 46385.5361446388, 46660.0, 39689.60310396859, 39884.20231595352, 44435.55564444314, 46308.5369146311, 46956.5304346959, 8132.593370331578, 8242.29940455068, 8491.023532293866, 8592.398532102943, 8596.441231319945, 31290.530642039932, 31824.0, 32385.838070810438, 32417.0, 32958.0, 35910.28179436449, 36220.27559448849, 40790.38814417727, 44298.0, 44468.77765611151, 9877.802443951225, 9890.159336456481, 9897.950510247403, 10039.598416063276, 10336.17310615134, 10438.791224175626, 10473.842892356774, 10639.521221544894, 10647.574097036342, 11049.39228342449, 10414.635487758194, 10466.476676166008, 10474.895251047392, 10497.47512624381, 10504.789904202025, 10573.577056917944, 10724.785504290026, 10752.462376881282, 10849.077828384676, 10869.29349592274, 10068.194544436574, 10215.182785377003, 10224.335418197794, 10258.897411025795, 10599.1520678344, 9056.864147037932, 9110.0, 9369.0, 9417.48203848795, 9448.433094014381, 8801.867971980297, 8904.73285801427, 8910.465372077697, 8946.0, 9213.447193168431], "unit": "ms", "name": "yui.html", "value": 5617.10106813105}], "name": "dromaeo_css", "value": 6338.804215875696}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 114.0, 115.0, 113.0, 102.0, 112.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 111.5}, {"lowerIsBetter": true, "replicates": [154.0, 134.0, 161.0, 173.0, 129.0, 160.0, 148.0, 129.0, 176.0, 128.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.2}, {"lowerIsBetter": true, "replicates": [161.0, 161.0, 160.0, 160.0, 161.0, 161.0, 159.0, 162.0, 162.0, 163.0], "unit": "ms", "name": "audio-dft", "value": 161.0}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 83.0, 92.0, 75.0, 74.0, 72.0, 120.0, 95.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 83.1}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 124.0, 90.0, 91.0, 90.0, 131.0, 91.0, 91.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 101.5}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.1}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 145.0, 146.0, 147.0, 146.0, 147.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 71.0, 69.0, 69.0, 70.0, 70.0, 70.0, 70.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 69.6}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 68.0, 69.0, 69.0, 69.0, 68.0, 67.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.2}, {"lowerIsBetter": true, "replicates": [80.0, 82.0, 85.0, 83.0, 90.0, 82.0, 83.0, 84.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [129.0, 118.0, 127.0, 120.0, 130.0, 126.0, 129.0, 125.0, 121.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 125.0}, {"lowerIsBetter": true, "replicates": [137.0, 137.0, 148.0, 152.0, 153.0, 135.0, 148.0, 148.0, 145.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.6}, {"lowerIsBetter": true, "replicates": [68.0, 71.0, 68.0, 69.0, 68.0, 68.0, 68.0, 67.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1515.8}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.5858007524947], "unit": "score", "name": "Richards", "value": 215.80112600000007}, {"lowerIsBetter": false, "replicates": [186.42803877703207], "unit": "score", "name": "DeltaBlue", "value": 354.6569519999998}, {"lowerIsBetter": false, "replicates": [280.8988764044944], "unit": "score", "name": "Encrypt", "value": 947.6043599999998}, {"lowerIsBetter": false, "replicates": [5112.244897959184], "unit": "score", "name": "Decrypt", "value": 52.067341317365305}, {"lowerIsBetter": false, "replicates": [2014.0845070422536], "unit": "score", "name": "RayTrace", "value": 367.4071258741258}, {"lowerIsBetter": false, "replicates": [781.8608287724785], "unit": "score", "name": "Earley", "value": 852.4061770000001}, {"lowerIsBetter": false, "replicates": [12231.707317073171], "unit": "score", "name": "Boyer", "value": 54.4865064805583}, {"lowerIsBetter": false, "replicates": [26394.736842105263], "unit": "score", "name": "RegExp", "value": 34.51388833499503}, {"lowerIsBetter": false, "replicates": [600.3573555687909], "unit": "score", "name": "Splay", "value": 135.73748908730155}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19877.196200889786}]} 12:37:27 INFO - RETURN: dromaeo_css: 6338.80 12:37:27 INFO - RETURN: kraken: 1515.80 12:37:27 INFO - RETURN: v8_7: 19877.20 12:37:27 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19877.20"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1515.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6338.80"}}} 12:37:27 INFO - Return code: 0 12:37:27 INFO - # TBPL SUCCESS # 12:37:27 INFO - Running post-action listener: _resource_record_post_action 12:37:27 INFO - Running post-run listener: _resource_record_post_run 12:37:28 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511377408; Read time: 8; Write time: 448012 12:37:28 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 171585536; Read time: 0; Write time: 155900 12:37:28 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 339791872; Read time: 0; Write time: 292112 12:37:28 INFO - Running post-run listener: _upload_blobber_files 12:37:28 INFO - Blob upload gear active. 12:37:28 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:28 INFO - Copying logs to upload dir... 12:37:28 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1261.981819 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 1 secs) (at 2015-11-23 12:37:26.716324) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:26.719424) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010046 build_url: 'https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/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-11-23 12:37:26.769932) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:26.770260) ========= 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=e10134013339c31d8d0c4708000001d6-1448309784.382397-1757751599 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:26.821271) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:26.821573) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:26.821852) ========= ========= Total master_lag: 0.20 =========