builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1448309849.49 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.489131) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.489709) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.490120) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.004125 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.506420) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.506969) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.517248) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.517662) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.003943 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.566300) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.566669) ========= 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:17:29.567086) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.567387) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 12:17:29-- 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% 218M=0s 2015-11-23 12:17:29 (218 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.104485 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.684783) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.685197) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022055 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.736808) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:29.737436) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 12:17:30,051 truncating revision to first 12 chars 2015-11-23 12:17:30,051 Setting DEBUG logging. 2015-11-23 12:17:30,051 attempt 1/10 2015-11-23 12:17:30,051 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:17:30,310 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=0.527229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:30.278463) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:30.278871) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:30.289234) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:17:30.289633) ========= 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:17:30.290138) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-23 12:17:30.290460) ========= /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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:17:30 INFO - MultiFileLogger online at 20151123 12:17:30 in /builds/slave/test 12:17:30 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:17:30 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:17:30 INFO - {'append_to_log': False, 12:17:30 INFO - 'base_work_dir': '/builds/slave/test', 12:17:30 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:17:30 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:17:30 INFO - 'branch': 'Fx-Team-Non-PGO', 12:17:30 INFO - 'buildbot_json_path': 'buildprops.json', 12:17:30 INFO - 'config_files': ('talos/linux_config.py',), 12:17:30 INFO - 'default_actions': ('clobber', 12:17:30 INFO - 'read-buildbot-config', 12:17:30 INFO - 'download-and-extract', 12:17:30 INFO - 'populate-webroot', 12:17:30 INFO - 'create-virtualenv', 12:17:30 INFO - 'install', 12:17:30 INFO - 'run-tests'), 12:17:30 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:17:30 INFO - 'download_minidump_stackwalk': True, 12:17:30 INFO - 'download_symbols': 'ondemand', 12:17:30 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:17:30 INFO - 'tooltool.py': '/tools/tooltool.py', 12:17:30 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:17:30 INFO - '/tools/misc-python/virtualenv.py')}, 12:17:30 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:17:30 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:17:30 INFO - 'installer_path': 'installer.exe', 12:17:30 INFO - 'log_level': 'info', 12:17:30 INFO - 'log_name': 'talos', 12:17:30 INFO - 'log_to_console': True, 12:17:30 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:17:30 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:17:30 INFO - 'opt_config_files': (), 12:17:30 INFO - 'pip_index': False, 12:17:30 INFO - 'sps_profile': False, 12:17:30 INFO - 'sps_profile_interval': 0, 12:17:30 INFO - 'suite': 'dromaeojs', 12:17:30 INFO - 'system_bits': '64', 12:17:30 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:17:30 INFO - 'title': 'talos-linux64-ix-045', 12:17:30 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:17:30 INFO - 'use_talos_json': True, 12:17:30 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:17:30 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:17:30 INFO - 'work_dir': 'build'} 12:17:30 INFO - ##### 12:17:30 INFO - ##### Running clobber step. 12:17:30 INFO - ##### 12:17:30 INFO - Running pre-action listener: _resource_record_pre_action 12:17:30 INFO - Running main action method: clobber 12:17:30 INFO - rmtree: /builds/slave/test/build 12:17:30 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:17:31 INFO - Running post-action listener: _resource_record_post_action 12:17:31 INFO - ##### 12:17:31 INFO - ##### Running read-buildbot-config step. 12:17:31 INFO - ##### 12:17:31 INFO - Running pre-action listener: _resource_record_pre_action 12:17:31 INFO - Running main action method: read_buildbot_config 12:17:31 INFO - Using buildbot properties: 12:17:31 INFO - { 12:17:31 INFO - "properties": { 12:17:31 INFO - "buildnumber": 2110, 12:17:31 INFO - "product": "firefox", 12:17:31 INFO - "script_repo_revision": "production", 12:17:31 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:17:31 INFO - "repository": "", 12:17:31 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:17:31 INFO - "buildid": "20151121014332", 12:17:31 INFO - "slavename": "talos-linux64-ix-045", 12:17:31 INFO - "pgo_build": "False", 12:17:31 INFO - "basedir": "/builds/slave/test", 12:17:31 INFO - "project": "", 12:17:31 INFO - "platform": "ubuntu64_hw", 12:17:31 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:17:31 INFO - "slavebuilddir": "test", 12:17:31 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:17:31 INFO - "branch": "fx-team", 12:17:31 INFO - "repo_path": "integration/fx-team", 12:17:31 INFO - "stage_platform": "linux64", 12:17:31 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 12:17:31 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:17:31 INFO - }, 12:17:31 INFO - "sourcestamp": { 12:17:31 INFO - "repository": "", 12:17:31 INFO - "hasPatch": false, 12:17:31 INFO - "project": "", 12:17:31 INFO - "branch": "fx-team-linux64-talos", 12:17:31 INFO - "changes": [ 12:17:31 INFO - { 12:17:31 INFO - "category": null, 12:17:31 INFO - "files": [ 12:17:31 INFO - { 12:17:31 INFO - "url": null, 12:17:31 INFO - "name": "https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:17:31 INFO - } 12:17:31 INFO - ], 12:17:31 INFO - "repository": "", 12:17:31 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 12:17:31 INFO - "who": "dgottwald@mozilla.com", 12:17:31 INFO - "when": 1448100613, 12:17:31 INFO - "number": 6692170, 12:17:31 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 12:17:31 INFO - "project": "", 12:17:31 INFO - "at": "Sat 21 Nov 2015 02:10:13", 12:17:31 INFO - "branch": "fx-team-linux64-talos", 12:17:31 INFO - "revlink": "", 12:17:31 INFO - "properties": [ 12:17:31 INFO - [ 12:17:31 INFO - "buildid", 12:17:31 INFO - "20151121014332", 12:17:31 INFO - "Change" 12:17:31 INFO - ], 12:17:31 INFO - [ 12:17:31 INFO - "builduid", 12:17:31 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 12:17:31 INFO - "Change" 12:17:31 INFO - ], 12:17:31 INFO - [ 12:17:31 INFO - "pgo_build", 12:17:31 INFO - "False", 12:17:31 INFO - "Change" 12:17:31 INFO - ] 12:17:31 INFO - ], 12:17:31 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:17:31 INFO - } 12:17:31 INFO - ], 12:17:31 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:17:31 INFO - } 12:17:31 INFO - } 12:17:31 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:17:31 INFO - Running post-action listener: _resource_record_post_action 12:17:31 INFO - ##### 12:17:31 INFO - ##### Running download-and-extract step. 12:17:31 INFO - ##### 12:17:31 INFO - Running pre-action listener: _resource_record_pre_action 12:17:31 INFO - Running main action method: download_and_extract 12:17:31 INFO - mkdir: /builds/slave/test/build/tests 12:17: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:17:31 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:17:31 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:17:31 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:17:31 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:17:31 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:17:32 INFO - Downloaded 1302 bytes. 12:17:32 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:17:32 INFO - Using the following test package requirements: 12:17:32 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:32 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:17:32 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'jsshell-linux-x86_64.zip'], 12:17:32 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:17:32 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:32 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:17:32 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:17:32 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:17:32 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:17:32 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:17:32 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:17:32 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:17:32 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:32 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:17:32 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:17:32 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:17:32 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:17:32 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:17:33 INFO - Downloaded 21339409 bytes. 12:17:33 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:17:33 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:33 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:17:34 INFO - Return code: 0 12:17:34 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:17:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:34 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:17:34 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:17:34 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:17:34 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:17:34 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:17:35 INFO - Downloaded 21339409 bytes. 12:17:35 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:17:35 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:17:35 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:17:36 INFO - Return code: 0 12:17:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:36 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:17:36 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:17:36 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:17:36 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:17:36 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:17:37 INFO - Downloaded 11130997 bytes. 12:17:37 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:17:37 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:17:37 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:17:38 INFO - Return code: 0 12:17: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:17:38 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:17:38 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:17:38 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:17:38 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:17:38 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:17:39 INFO - Downloaded 55909927 bytes. 12:17:39 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:17:39 INFO - mkdir: /builds/slave/test/properties 12:17:39 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:17:39 INFO - Writing to file /builds/slave/test/properties/build_url 12:17:39 INFO - Contents: 12:17:39 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:17:39 INFO - Running post-action listener: _resource_record_post_action 12:17:39 INFO - Running post-action listener: set_extra_try_arguments 12:17:39 INFO - ##### 12:17:39 INFO - ##### Running populate-webroot step. 12:17:39 INFO - ##### 12:17:39 INFO - Running pre-action listener: _resource_record_pre_action 12:17:39 INFO - Running main action method: populate_webroot 12:17:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:17:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:17:39 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:17:39 INFO - '../fennec_ids.txt'], 12:17:39 INFO - 'tests': ['tcheck2']}, 12:17:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:17:39 INFO - '--tppagecycles', 12:17:39 INFO - '7'], 12:17:39 INFO - 'tests': ['tsvgm']}}, 12:17:39 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:17:39 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:17:39 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:39 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:17:39 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:39 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:17:39 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'tests': ['damp', 'tps']}, 12:17:39 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['damp', 'tps']}, 12:17:39 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:17:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:17:39 INFO - 'other': {'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'other_l64': {'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'other_nol64': {'tests': ['a11yr', 12:17:39 INFO - 'ts_paint', 12:17:39 INFO - 'tpaint', 12:17:39 INFO - 'sessionrestore', 12:17:39 INFO - 'sessionrestore_no_auto_restore']}, 12:17:39 INFO - 'svgr': {'tests': ['tsvgx', 12:17:39 INFO - 'tsvgr_opacity', 12:17:39 INFO - 'tart', 12:17:39 INFO - 'tscrollx', 12:17:39 INFO - 'cart']}, 12:17:39 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['tsvgx', 12:17:39 INFO - 'tsvgr_opacity', 12:17:39 INFO - 'tart', 12:17:39 INFO - 'tscrollx', 12:17:39 INFO - 'cart']}, 12:17:39 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'tests': ['tp5o']}, 12:17:39 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'talos_options': ['--e10s'], 12:17:39 INFO - 'tests': ['tp5o']}, 12:17:39 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'talos_options': ['--xperf_path', 12:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:39 INFO - 'tests': ['tp5n']}, 12:17:39 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:17:39 INFO - 'talos_options': ['--e10s', 12:17:39 INFO - '--xperf_path', 12:17:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:17:39 INFO - 'tests': ['tp5n']}}, 12:17:39 INFO - 'talos.zip': {'path': '', 12:17:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:17:39 INFO - Running post-action listener: _resource_record_post_action 12:17:39 INFO - ##### 12:17:39 INFO - ##### Running create-virtualenv step. 12:17:39 INFO - ##### 12:17:39 INFO - Running pre-action listener: _resource_record_pre_action 12:17:39 INFO - Running main action method: create_virtualenv 12:17:39 INFO - Creating virtualenv /builds/slave/test/build/venv 12:17:39 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:17:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:17:40 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:17:40 INFO - Using real prefix '/usr' 12:17:40 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:17:40 INFO - Installing distribute.............................................................................................................................................................................................done. 12:17:42 INFO - Installing pip.................done. 12:17:42 INFO - Return code: 0 12:17:42 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:17: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:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17: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', 'pip>=1.5'] in /builds/slave/test/build 12:17: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 pip>=1.5 12:17:42 INFO - Using env: {'DISPLAY': ':0', 12:17:42 INFO - 'HOME': '/home/cltbld', 12:17:42 INFO - 'LANG': 'en_US.UTF-8', 12:17:42 INFO - 'LANGUAGE': 'en_US:en', 12:17:42 INFO - 'LOGNAME': 'cltbld', 12:17:42 INFO - 'MAIL': '/var/mail/cltbld', 12:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:42 INFO - 'MOZ_NO_REMOTE': '1', 12:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:42 INFO - 'NO_EM_RESTART': '1', 12:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:42 INFO - 'PWD': '/builds/slave/test', 12:17:42 INFO - 'SHELL': '/bin/bash', 12:17:42 INFO - 'SHLVL': '1', 12:17:42 INFO - 'TERM': 'linux', 12:17:42 INFO - 'TMOUT': '86400', 12:17:42 INFO - 'USER': 'cltbld', 12:17:42 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:42 INFO - '_': '/tools/buildbot/bin/python'} 12:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:42 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:17:42 INFO - Cleaning up... 12:17:42 INFO - Return code: 0 12:17:42 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:17: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:17:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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:17:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17: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', '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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17: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', 'psutil>=0.7.1'] in /builds/slave/test/build 12:17: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 psutil>=0.7.1 12:17:42 INFO - Using env: {'DISPLAY': ':0', 12:17:42 INFO - 'HOME': '/home/cltbld', 12:17:42 INFO - 'LANG': 'en_US.UTF-8', 12:17:42 INFO - 'LANGUAGE': 'en_US:en', 12:17:42 INFO - 'LOGNAME': 'cltbld', 12:17:42 INFO - 'MAIL': '/var/mail/cltbld', 12:17:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:42 INFO - 'MOZ_NO_REMOTE': '1', 12:17:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:42 INFO - 'NO_EM_RESTART': '1', 12:17:42 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:42 INFO - 'PWD': '/builds/slave/test', 12:17:42 INFO - 'SHELL': '/bin/bash', 12:17:42 INFO - 'SHLVL': '1', 12:17:42 INFO - 'TERM': 'linux', 12:17:42 INFO - 'TMOUT': '86400', 12:17:42 INFO - 'USER': 'cltbld', 12:17:42 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:42 INFO - '_': '/tools/buildbot/bin/python'} 12:17:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:42 INFO - Downloading/unpacking psutil>=0.7.1 12:17:42 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:17:42 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:17:42 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:17:42 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:17:42 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:17:42 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:17:44 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:17:44 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:17:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:17:44 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:44 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:44 INFO - Installing collected packages: psutil 12:17:44 INFO - Running setup.py install for psutil 12:17:44 INFO - building 'psutil._psutil_linux' extension 12:17:44 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:17:44 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:17:45 INFO - building 'psutil._psutil_posix' extension 12:17:45 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:17:45 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:17:45 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:17:45 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:17:45 INFO - Successfully installed psutil 12:17:45 INFO - Cleaning up... 12:17:45 INFO - Return code: 0 12:17:45 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:45 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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17:45 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:17:45 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:17:45 INFO - Using env: {'DISPLAY': ':0', 12:17:45 INFO - 'HOME': '/home/cltbld', 12:17:45 INFO - 'LANG': 'en_US.UTF-8', 12:17:45 INFO - 'LANGUAGE': 'en_US:en', 12:17:45 INFO - 'LOGNAME': 'cltbld', 12:17:45 INFO - 'MAIL': '/var/mail/cltbld', 12:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:45 INFO - 'MOZ_NO_REMOTE': '1', 12:17:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:45 INFO - 'NO_EM_RESTART': '1', 12:17:45 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:45 INFO - 'PWD': '/builds/slave/test', 12:17:45 INFO - 'SHELL': '/bin/bash', 12:17:45 INFO - 'SHLVL': '1', 12:17:45 INFO - 'TERM': 'linux', 12:17:45 INFO - 'TMOUT': '86400', 12:17:45 INFO - 'USER': 'cltbld', 12:17:45 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:45 INFO - '_': '/tools/buildbot/bin/python'} 12:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:45 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:17: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:17: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:17: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:17: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:17: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:17: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:17:47 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:17:47 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:17:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:17:47 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:17:47 INFO - Installing collected packages: mozsystemmonitor 12:17:47 INFO - Running setup.py install for mozsystemmonitor 12:17:47 INFO - Successfully installed mozsystemmonitor 12:17:47 INFO - Cleaning up... 12:17:47 INFO - Return code: 0 12:17:47 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:17:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:17:47 INFO - Using env: {'DISPLAY': ':0', 12:17:47 INFO - 'HOME': '/home/cltbld', 12:17:47 INFO - 'LANG': 'en_US.UTF-8', 12:17:47 INFO - 'LANGUAGE': 'en_US:en', 12:17:47 INFO - 'LOGNAME': 'cltbld', 12:17:47 INFO - 'MAIL': '/var/mail/cltbld', 12:17:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:47 INFO - 'MOZ_NO_REMOTE': '1', 12:17:47 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:47 INFO - 'NO_EM_RESTART': '1', 12:17:47 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:47 INFO - 'PWD': '/builds/slave/test', 12:17:47 INFO - 'SHELL': '/bin/bash', 12:17:47 INFO - 'SHLVL': '1', 12:17:47 INFO - 'TERM': 'linux', 12:17:47 INFO - 'TMOUT': '86400', 12:17:47 INFO - 'USER': 'cltbld', 12:17:47 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:47 INFO - '_': '/tools/buildbot/bin/python'} 12:17:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:47 INFO - Downloading/unpacking blobuploader==1.2.4 12:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:47 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:17:49 INFO - Downloading blobuploader-1.2.4.tar.gz 12:17:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:17:49 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:17:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 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:17:49 INFO - Downloading docopt-0.6.1.tar.gz 12:17:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:17:50 INFO - Installing collected packages: blobuploader, requests, docopt 12:17:50 INFO - Running setup.py install for blobuploader 12:17:50 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:17:50 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:17:50 INFO - Running setup.py install for requests 12:17:50 INFO - Running setup.py install for docopt 12:17:50 INFO - Successfully installed blobuploader requests docopt 12:17:50 INFO - Cleaning up... 12:17:50 INFO - Return code: 0 12:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:50 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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17:50 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:17:50 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:17:50 INFO - Using env: {'DISPLAY': ':0', 12:17:50 INFO - 'HOME': '/home/cltbld', 12:17:50 INFO - 'LANG': 'en_US.UTF-8', 12:17:50 INFO - 'LANGUAGE': 'en_US:en', 12:17:50 INFO - 'LOGNAME': 'cltbld', 12:17:50 INFO - 'MAIL': '/var/mail/cltbld', 12:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:50 INFO - 'MOZ_NO_REMOTE': '1', 12:17:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:50 INFO - 'NO_EM_RESTART': '1', 12:17:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:50 INFO - 'PWD': '/builds/slave/test', 12:17:50 INFO - 'SHELL': '/bin/bash', 12:17:50 INFO - 'SHLVL': '1', 12:17:50 INFO - 'TERM': 'linux', 12:17:50 INFO - 'TMOUT': '86400', 12:17:50 INFO - 'USER': 'cltbld', 12:17:50 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:50 INFO - '_': '/tools/buildbot/bin/python'} 12:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:50 INFO - Running setup.py (path:/tmp/pip-s6yu9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:50 INFO - Running setup.py (path:/tmp/pip-EYmcPq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:50 INFO - Running setup.py (path:/tmp/pip-oXqJBD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:51 INFO - Running setup.py (path:/tmp/pip-rLWDo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:51 INFO - Running setup.py (path:/tmp/pip-aesMwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:51 INFO - Running setup.py (path:/tmp/pip-gWTuSr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:51 INFO - Running setup.py (path:/tmp/pip-AvgDEt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:51 INFO - Running setup.py (path:/tmp/pip-sNwxeK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:51 INFO - Running setup.py (path:/tmp/pip-mRWy6J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:51 INFO - Running setup.py (path:/tmp/pip-SochTJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:51 INFO - Running setup.py (path:/tmp/pip-njboAd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:51 INFO - Running setup.py (path:/tmp/pip-6uY46b-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:51 INFO - Running setup.py (path:/tmp/pip-uPPnuS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:51 INFO - Running setup.py (path:/tmp/pip-mjnIeD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:52 INFO - Running setup.py (path:/tmp/pip-FraTUI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:52 INFO - Running setup.py (path:/tmp/pip-tvDbe4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:52 INFO - Running setup.py (path:/tmp/pip-KmqSez-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:17:52 INFO - Running setup.py install for manifestparser 12:17:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:17:52 INFO - Running setup.py install for mozcrash 12:17:52 INFO - Running setup.py install for mozdebug 12:17:52 INFO - Running setup.py install for mozdevice 12:17:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:17:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:17:52 INFO - Running setup.py install for mozfile 12:17:52 INFO - Running setup.py install for mozhttpd 12:17:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:17:52 INFO - Running setup.py install for mozinfo 12:17:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:17:52 INFO - Running setup.py install for mozInstall 12:17:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Running setup.py install for mozleak 12:17:53 INFO - Running setup.py install for mozlog 12:17:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Running setup.py install for moznetwork 12:17:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Running setup.py install for mozprocess 12:17:53 INFO - Running setup.py install for mozprofile 12:17:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Running setup.py install for mozrunner 12:17:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:17:53 INFO - Running setup.py install for mozscreenshot 12:17:53 INFO - Running setup.py install for moztest 12:17:53 INFO - Running setup.py install for mozversion 12:17:53 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:17:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:17:54 INFO - Cleaning up... 12:17:54 INFO - Return code: 0 12:17:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:54 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:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:54 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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17:54 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:17:54 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:17:54 INFO - Using env: {'DISPLAY': ':0', 12:17:54 INFO - 'HOME': '/home/cltbld', 12:17:54 INFO - 'LANG': 'en_US.UTF-8', 12:17:54 INFO - 'LANGUAGE': 'en_US:en', 12:17:54 INFO - 'LOGNAME': 'cltbld', 12:17:54 INFO - 'MAIL': '/var/mail/cltbld', 12:17:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:54 INFO - 'MOZ_NO_REMOTE': '1', 12:17:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:54 INFO - 'NO_EM_RESTART': '1', 12:17:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:54 INFO - 'PWD': '/builds/slave/test', 12:17:54 INFO - 'SHELL': '/bin/bash', 12:17:54 INFO - 'SHLVL': '1', 12:17:54 INFO - 'TERM': 'linux', 12:17:54 INFO - 'TMOUT': '86400', 12:17:54 INFO - 'USER': 'cltbld', 12:17:54 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:54 INFO - '_': '/tools/buildbot/bin/python'} 12:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 INFO - Running setup.py (path:/tmp/pip-9YDFSd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 INFO - Running setup.py (path:/tmp/pip-8oCoCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 INFO - Running setup.py (path:/tmp/pip-0Qka0Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:17:54 INFO - Running setup.py (path:/tmp/pip-rlJyOb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:17:54 INFO - Running setup.py (path:/tmp/pip-l7_prY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:17:54 INFO - Running setup.py (path:/tmp/pip-7kMvMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:17:54 INFO - Running setup.py (path:/tmp/pip-vff69A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:17:54 INFO - Running setup.py (path:/tmp/pip-11vLnV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:17:54 INFO - Running setup.py (path:/tmp/pip-5P87My-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:17:54 INFO - Running setup.py (path:/tmp/pip-Dvmih_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:17:54 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:17:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:17:54 INFO - Running setup.py (path:/tmp/pip-Deixcz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 INFO - Running setup.py (path:/tmp/pip-WxinNu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 INFO - Running setup.py (path:/tmp/pip-WVuKAS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 INFO - Running setup.py (path:/tmp/pip-aEHZuB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 INFO - Running setup.py (path:/tmp/pip-IvmBlo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:17:55 INFO - Running setup.py (path:/tmp/pip-3UWshd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:17:55 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:17:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:17:55 INFO - Running setup.py (path:/tmp/pip-SxeBlm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:55 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:17:55 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:17:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:17:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:17:57 INFO - Downloading blessings-1.5.1.tar.gz 12:17:57 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:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:17:57 INFO - Installing collected packages: blessings 12:17:57 INFO - Running setup.py install for blessings 12:17:57 INFO - Successfully installed blessings 12:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:57 INFO - Reading from file tmpfile_stdout 12:17:57 INFO - Current package versions: 12:17:57 INFO - argparse == 1.2.1 12:17:57 INFO - blessings == 1.5.1 12:17:57 INFO - blobuploader == 1.2.4 12:17:57 INFO - docopt == 0.6.1 12:17:57 INFO - manifestparser == 1.1 12:17:57 INFO - mozInstall == 1.12 12:17:57 INFO - mozcrash == 0.16 12:17:57 INFO - mozdebug == 0.1 12:17:57 INFO - mozdevice == 0.47 12:17:57 INFO - mozfile == 1.2 12:17:57 INFO - mozhttpd == 0.7 12:17:57 INFO - mozinfo == 0.9 12:17:57 INFO - mozleak == 0.1 12:17:57 INFO - mozlog == 3.0 12:17:57 INFO - moznetwork == 0.27 12:17:57 INFO - mozprocess == 0.22 12:17:57 INFO - mozprofile == 0.27 12:17:57 INFO - mozrunner == 6.11 12:17:57 INFO - mozscreenshot == 0.1 12:17:57 INFO - mozsystemmonitor == 0.0 12:17:57 INFO - moztest == 0.7 12:17:57 INFO - mozversion == 1.4 12:17:57 INFO - psutil == 3.1.1 12:17:57 INFO - requests == 1.2.3 12:17:57 INFO - wsgiref == 0.1.2 12:17:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:17:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:17:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:17:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f3c13f07c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2aa36c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2b54900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, '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': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', '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:17:57 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:17:57 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:17:57 INFO - Using env: {'DISPLAY': ':0', 12:17:57 INFO - 'HOME': '/home/cltbld', 12:17:57 INFO - 'LANG': 'en_US.UTF-8', 12:17:57 INFO - 'LANGUAGE': 'en_US:en', 12:17:57 INFO - 'LOGNAME': 'cltbld', 12:17:57 INFO - 'MAIL': '/var/mail/cltbld', 12:17:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:17:57 INFO - 'MOZ_NO_REMOTE': '1', 12:17:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:17:57 INFO - 'NO_EM_RESTART': '1', 12:17:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:17:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:17:57 INFO - 'PWD': '/builds/slave/test', 12:17:57 INFO - 'SHELL': '/bin/bash', 12:17:57 INFO - 'SHLVL': '1', 12:17:57 INFO - 'TERM': 'linux', 12:17:57 INFO - 'TMOUT': '86400', 12:17:57 INFO - 'USER': 'cltbld', 12:17:57 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:17:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:17:57 INFO - '_': '/tools/buildbot/bin/python'} 12:17:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 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:17:57 INFO - Cleaning up... 12:17:57 INFO - Return code: 0 12:17:57 INFO - Running post-action listener: _resource_record_post_action 12:17:57 INFO - Running post-action listener: _start_resource_monitoring 12:17:57 INFO - Starting resource monitoring. 12:17:57 INFO - ##### 12:17:57 INFO - ##### Running install step. 12:17:57 INFO - ##### 12:17:57 INFO - Running pre-action listener: _resource_record_pre_action 12:17:57 INFO - Running main action method: install 12:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:17:58 INFO - Reading from file tmpfile_stdout 12:17:58 INFO - Detecting whether we're running mozinstall >=1.0... 12:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:17:58 INFO - Reading from file tmpfile_stdout 12:17:58 INFO - Output received: 12:17:58 INFO - Usage: mozinstall [options] installer 12:17:58 INFO - Options: 12:17:58 INFO - -h, --help show this help message and exit 12:17:58 INFO - -d DEST, --destination=DEST 12:17:58 INFO - Directory to install application into. [default: 12:17:58 INFO - "/builds/slave/test"] 12:17:58 INFO - --app=APP Application being installed. [default: firefox] 12:17:58 INFO - mkdir: /builds/slave/test/build/application 12:17:58 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:17:58 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:18:12 INFO - Reading from file tmpfile_stdout 12:18:12 INFO - Output received: 12:18:12 INFO - /builds/slave/test/build/application/firefox/firefox 12:18:12 INFO - Running post-action listener: _resource_record_post_action 12:18:12 INFO - ##### 12:18:12 INFO - ##### Running run-tests step. 12:18:12 INFO - ##### 12:18:12 INFO - Running pre-action listener: _resource_record_pre_action 12:18:12 INFO - Running main action method: run_tests 12:18:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:18:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:18:12 INFO - Python 2.7.3 12:18:12 INFO - Return code: 0 12:18:12 INFO - grabbing minidump binary from tooltool 12:18:12 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:18:12 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 0x2b9ab70>, '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 0x2bebdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2bec250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:18:12 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:18:12 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:18:12 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:18:12 INFO - Return code: 0 12:18:12 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:18:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:18:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:18:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:18:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:18:12 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-045', '--webServer', 'localhost'] in /builds/slave/test/build 12:18:12 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-045 --webServer localhost 12:18:12 INFO - Using env: {'DISPLAY': ':0', 12:18:12 INFO - 'HOME': '/home/cltbld', 12:18:12 INFO - 'LANG': 'en_US.UTF-8', 12:18:12 INFO - 'LANGUAGE': 'en_US:en', 12:18:12 INFO - 'LOGNAME': 'cltbld', 12:18:12 INFO - 'MAIL': '/var/mail/cltbld', 12:18:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:18:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:18:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:18:12 INFO - 'MOZ_NO_REMOTE': '1', 12:18:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:18:12 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:18:12 INFO - 'NO_EM_RESTART': '1', 12:18:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:18:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:18:12 INFO - 'PWD': '/builds/slave/test', 12:18:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:18:12 INFO - 'SHELL': '/bin/bash', 12:18:12 INFO - 'SHLVL': '1', 12:18:12 INFO - 'TERM': 'linux', 12:18:12 INFO - 'TMOUT': '86400', 12:18:12 INFO - 'USER': 'cltbld', 12:18:12 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927', 12:18:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:18:12 INFO - '_': '/tools/buildbot/bin/python'} 12:18:12 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-045', '--webServer', 'localhost'] with output_timeout 3600 12:18:12 INFO - mozversion INFO | application_buildid: 20151121014332 12:18:12 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 12:18:12 INFO - mozversion INFO | application_display_name: Nightly 12:18:12 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:18:12 INFO - mozversion INFO | application_name: Firefox 12:18:12 INFO - mozversion INFO | application_remotingname: firefox 12:18:12 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:18:12 INFO - mozversion INFO | application_vendor: Mozilla 12:18:12 INFO - mozversion INFO | application_version: 45.0a1 12:18:12 INFO - mozversion INFO | platform_buildid: 20151121014332 12:18:12 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 12:18:12 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:18:12 INFO - mozversion INFO | platform_version: 45.0a1 12:18:12 INFO - 2015-11-23 12:18:12,521 DEBUG : using testdate: 1448309892 12:18:12 INFO - 2015-11-23 12:18:12,521 DEBUG : actual date: 1448309892 12:18:12 INFO - 2015-11-23 12:18:12,529 INFO : starting webserver on 'localhost:49507' 12:18:12 INFO - 2015-11-23 12:18:12,529 INFO : Starting test suite talos-linux64-ix-045 12:18:12 INFO - 2015-11-23 12:18:12,530 INFO : Starting test dromaeo_css 12:18:12 INFO - 2015-11-23 12:18:12,530 DEBUG : operating with platform_type : linux_ 12:18:12 INFO - 2015-11-23 12:18:12,530 INFO : Initialising browser for dromaeo_css test... 12:18:12 INFO - 2015-11-23 12:18:12,537 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrtl0y/profile http://localhost:49507/getInfo.html 12:18:16 INFO - 2015-11-23 12:18:16,719 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:18:16 INFO - 2015-11-23 12:18:16,720 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:18:16 INFO - 2015-11-23 12:18:16,720 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:18:16 INFO - 2015-11-23 12:18:16,720 DEBUG : BROWSER_OUTPUT: __metrics 12:18:16 INFO - 2015-11-23 12:18:16,836 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:18:18 INFO - 2015-11-23 12:18:18,208 INFO : Browser initialized. 12:18:18 INFO - 2015-11-23 12:18:18,208 INFO : Running cycle 1/1 for dromaeo_css test... 12:18:18 INFO - 2015-11-23 12:18:18,208 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpyrtl0y/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:18:30 INFO - 2015-11-23 12:18:30,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139952128 12:18:30 INFO - 2015-11-23 12:18:30,101 DEBUG : BROWSER_OUTPUT: 12:19:21 INFO - 2015-11-23 12:19:21,629 DEBUG : BROWSER_OUTPUT: 1448309961628 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:21:33 INFO - 2015-11-23 12:21:33,442 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49507/tests/dromaeo/cssquery-ext.html) 12:21:35 INFO - 2015-11-23 12:21:35,195 DEBUG : BROWSER_OUTPUT: RSS: Main: 296800256 12:21:35 INFO - 2015-11-23 12:21:35,195 DEBUG : BROWSER_OUTPUT: 12:24:37 INFO - 2015-11-23 12:24:37,946 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-ext.html (next: http://localhost:49507/tests/dromaeo/cssquery-jquery.html) 12:24:38 INFO - 2015-11-23 12:24:38,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 217845760 12:24:38 INFO - 2015-11-23 12:24:38,529 DEBUG : BROWSER_OUTPUT: 12:27:40 INFO - 2015-11-23 12:27:40,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49507/tests/dromaeo/cssquery-mootools.html) 12:27:41 INFO - 2015-11-23 12:27:41,273 DEBUG : BROWSER_OUTPUT: RSS: Main: 210845696 12:27:41 INFO - 2015-11-23 12:27:41,273 DEBUG : BROWSER_OUTPUT: 12:30:43 INFO - 2015-11-23 12:30:43,224 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49507/tests/dromaeo/cssquery-prototype.html) 12:30:43 INFO - 2015-11-23 12:30:43,805 DEBUG : BROWSER_OUTPUT: RSS: Main: 203067392 12:30:43 INFO - 2015-11-23 12:30:43,806 DEBUG : BROWSER_OUTPUT: 12:33:46 INFO - 2015-11-23 12:33:46,564 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49507/tests/dromaeo/cssquery-yui.html) 12:33:47 INFO - 2015-11-23 12:33:47,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 205049856 12:33:47 INFO - 2015-11-23 12:33:47,146 DEBUG : BROWSER_OUTPUT: 12:36:49 INFO - 2015-11-23 12:36:49,762 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/dromaeo/cssquery-yui.html (next: http://localhost:49507/tests/dromaeo/cssquery-dojo.html) 12:36:50 INFO - 2015-11-23 12:36:50,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 249163776 12:36:50 INFO - 2015-11-23 12:36:50,008 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,009 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:50 INFO - 2015-11-23 12:36:50,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:50 INFO - 2015-11-23 12:36:50,009 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:50 INFO - 2015-11-23 12:36:50,009 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:50 INFO - 2015-11-23 12:36:50,011 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.842629442233;2730.208239610513;2733.726627337265;2752.40823223007;2759.9999999999995;4502.414686090804;4636.976815115928;4709.222978208596;4761.50004249554;4766.142094423002;4618.261078227484;4630.12027714734;4659.487456379796;4665.743384113873;4667.276572131316;4315.374270730742;4336.457942757155;4406.184855801687;4413.249747542925;4420.602145806877;4168.1038576706005;4343.826246950134;4383.517813040563;4446.955530444703;4477.70894891831;4235.216484950294;4259.6805239607;4315.935260971088;4319.1361727654285;4337.97831010846;4353.847615333448;4355.5644435556505;4364.847230346954;4376.6936314458;4391.143726973241;4168.812403441852;4260.0414906646065;4338.370936214263;4341.848035318749;4387.758673272969;4524.5701658342405;4548.7725613719185;4607.331936869169;4638.976805115986;4652.185867473178;5113.948860511385;5132.563732082777;5138.820141295037;5139.177731562932;5168.870778230536;4880.707157570557;5153.613478989053;5159.329287192679;5161.045206636784;5161.225816127573;4643.164230438553;4683.88290292742;4691.437027556681;4701.106789709944;4751.762411879392;5208.8958220835375;5219;5223.112070947948;5226.033183860998;5228.764705588258;4774.379330686988;5004.973980334023;5018.2974383586325;5020.573251273682;5067.087924173684;4982.701037937735;4983.875403114951;4997.575206107449;5080.314157588678;5121.718305493234;5078.238264260391;5101.464346243591;5104.693718376835;5106.489351064938;5148.304978827885;5056;5064.822731204464;5067.797288108508;5070.949290507121;5071.0872043032605;4041.9797901010893;4108.342665173558;4136.110736191733;4142.834286628501;4218.261804184255;3726.1057346236707;3726.2920045191327;3739.102615372291;3757.9436308455397;3765.058735316171;4404.581564751344;4408.801603927767;4414.977925110354;4438;4443.289073748185;4778.880527986828;4882.853514394574;4891.779869905863;5020.347354843847;5123.615728820353;4349.3041113421705;4390.385346051556;4404.207242696281;4410.470743510799;4438.045820148684;4526.502084770673;4528.47922488918;4528.841490547815;4532.524084971096;4576.931346029813;4630.120277147331;4732.645051621211;4736.739479328532;4868.269759536027;4868.707877527359;4630.791614377294;4940.505949405031;5003.949960500348;5017.799288028584;5027.145385284583;4853.466118727008;4873.025394920959;4873.6832105913;4874.171390863491;4920.21276595743;4775.5463230993;4876.951230487792;4883.316335712932;5068.619853511075;5109.616778741535;4922.4339200992345;4959.454460009469;4962.950370496394;4983.352164218629;4984.975075124601;4790.592799612072;4797.736124513046;4797.880052998564;4834.395700537433;4932.679375840559;4871.128632440388;4875;4875.04936537386;4886.828960986349;4980.526849949249;4738.360321356573;4778.307145463958;4779.808807647794;4816.301636262652;4824.831130910401;4726.1020406122725;4783.832565860178;4799.136155492045;4838.177509823268;4908.631852610997;4871.732054737024;4875.390576177978;4881.292212629078;4900.583450406612;4906.3376444181 12:36:50 INFO - 2015-11-23 12:36:50,012 DEBUG : BROWSER_OUTPUT: |1;ext.html;560.3751816724352;567.0416995277983;572.3132241310427;574.9195112684222;584.7456356484927;28718.56922146167;29400;35040.47439288413;35635.643643563555;35711;41288.142033608485;41735.165296694046;41814.581854181524;41937.85466090048;41943.58056419435;7018.824529386755;7940.6029698514985;8110.594470276492;8145;8148.75553733386;7128.108986376703;7202.675879585405;7236.348728614424;7238.601876896769;9789.706308810748;9985.700428987142;10165.085142337188;10185.337953033066;10196.133328667072;10202.744931376701;10041.04610062043;10141.239407044464;10196.847047294297;10198.235132365102;10201.897981020169;7172.892406613905;7384.926150738477;10087.646932357406;10487.73780655482;10511.474426278655;36585.45121823175;36935.445968310494;37044.259114817825;37045.25909481822;37172.25655486875;2975;3002.9249268768235;3024.21370443684;3480.564929383827;3585.480105384731;28585.57121643177;28828.567571486445;28913.54234890016;29025;29247.707522924924;3352.4534133801058;3365.7475689323155;3385.373705864423;3440.8623655053766;3510.1751088494184;231711;232202;232368;232531.83734081392;232572;52898.471015290124;54145;56654;60785;62856;57558;57572.424275756704;57789.13316300259;57824;57985.420145798846;12356.876431235572;12556.623301300975;12563.371831408393;12581.182223155465;12584.18202816814;9156.816863662689;9199.540022998823;9230.769230769285;9247.352685311964;9337.766555836159;19176.389089622393;19416.80858056219;19558.70661940072;19565;19584.608307833765;7289.489735718449;7545.50954187987;7567.394608431312;7599.164091949881;7658.157602663702;821.9958900205461;822.173715416015;975.1077763846001;1008.6570566007446;1056.6988408303596;26677.466450671265;26922.461550769265;27129.45741085167;27198.72801271962;27833.16500504988;943.834828904939;948.0466454883153;988.3526290279879;1010.1565193063874;1025.5231317437429;13543.119697219847;13603.251821149932;13795.310234488235;13827.377768000464;13843.861561384258;288626;294009;294523;295228;295264;47186.29220561694;47284.76357618259;47313.763431182626;47373;47382.76308618435;1160.3733983648904;1162.5756598841363;1182.196106647488;1195.0917302849723;1196.1029228078942;25299.873500633115;25638.359041023377;26219.21342359732;26320.34199145037;26335.34161645974;41637.58362416337;41984.58015419807;42066.789666051474;42103.36844947389;42190.57809421989;265009;266290;267695;268214;268743;25247.87376063108;25750;28961.7103828959;29135.271618209714;29260.268493287836;39131.217375652894;39543.20913581655;39611.2077758449;39922;40100.39849402203;32935.67064329326;33126.80545871122;33781.66218337785;34314.48528272128;34405.483917740756;25205.87397063003;32864;33544.49683254704;34633.30733385268;35246.29507409889;25842.483150337262;26091.739082608932;31227.375452491277;31604.525932111497;31630;24560.50878982446;29779.255518612208;30639;30808.845955770976;30986.535201972438;23142.76857231406;24060.87969560211;24067.638985414884;24426.51146977015;25860.612090819028 12:36:50 INFO - 2015-11-23 12:36:50,013 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.7985269280353;324.346441919532;337.55779928293924;340.4416756519307;340.7887109991805;11900.22648527845;12286.324252166127;14738.042027268233;15222;15230.238488075593;13425.798613020812;13846.100003499765;14105.2242126683;14651.706965860676;14668.853311466883;4596.6322694184555;4856;5030.06943715412;5034.119029169899;5842.0652695568715;3608.9097772555633;3702.4261239507787;5473.0969390050595;5679.148127780845;5739.655620662774;5736.483716465538;5774.018416869121;5784.074548072309;5786.392428794979;5812.244408226946;5581.6930068846195;5717.885642287172;5728.742206600692;5737.741801618937;5738.139279108125;4997.6501644884875;5019.121653710586;5028.823991160292;5042;5042.369703787027;19098.522536936547;19111;19317.323893663655;19835;19854.20583176671;1925.894075825829;2018.0414303206007;2028.949276268105;2029.0564887327464;2039.2454791727157;12828.102032857703;12854.485820567166;12886.80669789954;13055.738885222243;13148.40832162555;1617.7007253658112;1622.2537632688977;1680.8907421017595;1687.7890263717036;1763.374002229203;52765.73617131928;53614.73192634051;54681.45318546843;54879.451205488236;56254.43745562533;9156.8626470603;9300.953495232481;9542.952285238669;9558.665446709332;9604.66383676568;12113.939430302968;12120.878791212152;12121.878781212252;12125.029997600172;12127.39363031845;6628.635425051669;6636.435902948207;6690.163729533809;6694.230163531256;6714.966425167843;6121.112438696364;6174.320824709278;6197.5351848611535;6206.286277078104;6215.906761398583;5660.858478537987;5712.542996560265;5717.628354156966;5742.885142297214;5767.36558978512;1527.7173722861305;1622.7971503562055;1624.894381865175;1634.3054201964355;1693.09419460588;775.3835700618022;873.8383399071192;912.493566070837;958.8178246133212;1021.1728499915092;14815.92592037033;15229.695406092038;15511.146886921102;15902.602434938988;16503.587410314838;753.88691696246;823.2549542663899;844.2992316377515;855.5807654249373;928.5403725155955;8477.321814254845;8648.264897483785;8745.344099192585;8992.145746154105;9121;468549;490638;492725;493284;495217;67059;67973;69105.65447172833;69320.30679693239;70271;1069.5507288309684;1077.4451157653814;1085.6634443322596;1086.28305318491;1087.842262871895;13845.428138732263;13922.860771392156;13946.372413241226;14028.2985850705;14191.858081419054;31161.37677246488;31953.201169970936;32033;32266;32563;41623.37564936589;42983;43510.56489435192;43745.78127109344;44284;8648.135186481302;9041.547922603711;9048.41185322952;9054.909450905407;9291.814163716823;10464.215183861088;10505.266631006105;10533.052025317758;11188.328700278009;15694.372225110868;12978.67553311137;13320.600381988555;13572.253526055767;13808.654783630489;14149.787753183504;4259.297215959456;7568;12688.936555317165;13550.661490929302;13559;10889.564417423215;11198.552057917917;13647.931760341531;13817.447302107803;13902.096363736326;8278.420510564203;8554.615042323236;8641.783955401166;8664;8877.822443551222;8793.956030219808;8864;8864.86702699447;11604;12269.69325766863 12:36:50 INFO - 2015-11-23 12:36:50,013 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1269.631806776035;1655.884088113832;1674.9581260468487;1706.3004168291004;1724.9568760780983;5605;6432.742690292389;6708.396244338009;6722.663866806664;6723.966380168093;6582.967085164568;6675.231063768106;6684.030815531745;6687.665616719169;6695.263521012685;2063.277852751536;2077.0237988145545;2081.573277478121;2081.698153767703;2083.7291152150274;2063.4531849060013;2083.104265165978;2091.0381224636685;2107.546877421354;2108.525581744103;2026.1186383922966;2049.9692504612444;2050.5386288085137;2059.7631272403714;2061.288855344904;2021.2319318658963;2032.725582046427;2038.5515186659059;2043.2950632031925;2045.5908818236264;2034.257496013959;2034.7761746207905;2073;2077.314486219544;2082;5516.172574113875;5695.14572814077;6571.539992200548;6606.471482281406;6627.73489060437;3828.062124779419;3915.138669492707;3922;3939.684825213976;3954.8813535593977;2660.0024990628513;2711.7559419652325;2750.972490275112;2763.599278104684;2777.1113243762006;757.2008314362104;787.3543694170725;864.2178828160525;882.6778225947482;883.1742320929951;8528.104549022388;8539.530325832076;8555.743327700178;8559.27246184075;8575.228229459317;3794.962050379516;3799.525059367579;3868.787216703052;3941.7043721720984;3959.8416063357145;7649.464537482434;7658;7662.9233707663325;7666.041744781903;7679.884801727979;4131.876043718633;4142.378643203544;4142.958570414317;4146.3158578834755;4150.190712810973;3773.396256598931;3776.4524143999515;3781.1303400217553;3781.3193625147187;3785.37541305687;3250.6424293327714;3268.4116858965613;3297.554830097954;3300.851461684182;3302.0424077017874;1069.652362982034;1084.2789544952675;1088.031651829872;1091.6888686724246;1095.6165342130191;1130.9943450282697;1148.385613696685;1168.6085161470833;1176.2942234659135;1193.2780667696093;6371.904421433682;6378.521610879203;6402.391772781578;6408.583442076343;6419.293877673452;995.0894931138073;1009.5255230041869;1022.6676330192718;1034;1039.9948000259951;5017.172166592544;5020.297158397827;5047.394312682502;5063.468335824759;5065.468125846806;7186.173590037108;7630.2751238632245;7645.961770191114;7896.763097107096;7897.05235371759;7279.05372301608;7665.3101220890385;7804.3756499479905;7823.804404889809;7893.052833659997;6185.721642526097;6318.7472501100365;6321.209848768904;6323.494120470351;6327.050942358591;6232.065190221503;6318;6323.430891219812;6325.051242313506;6329.936700633119;6982.895256571257;7185.173705023989;7237.8914316284245;7258.056452661121;7293.197748247795;7216.96391518039;7289.052423184952;7431.777046688608;7434.293742094493;7501.512401693873;5939.46544810969;6000.519958403404;6006.129111278753;6011.7595296187665;6014.398560143951;6440.066190402459;6488.059231411325;6491.578047426902;6496.382843629847;6512;5941.31674857397;5989.580729348903;6001.459868611846;6006.309274433496;6209.472194863307;5811.186433899173;5835.4748072673665;5856.238688970577;5882.588218824641;5883.176355310175;6133.141360209664;6152.384761523812;6155.384461553809;6177.84555386119;6178;5683.6305640134915;5690.260266165372;5704.229928959703;5765.798197063083;5776;5434.10337294342;5466.480684334982;5471.932973070372;5477.808276710296;5488.368837583729 12:36:50 INFO - 2015-11-23 12:36:50,015 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.35053686185285;307.58629643129984;312.968703129687;316.2741508238592;319.38677738741615;5265.526102650761;5314.867128321785;5360.973195134028;5364.892702145955;5376.462353764621;5299.576033917287;5303.549198318147;5310.70791106489;5312.150055991042;5322.8137015204475;3927.3323534998976;4006.2187873364705;4199.68502362324;4204.390363397306;4204.516480604724;4075.4294398784195;4134.421181034658;4199.643030342425;4206.663466922654;4206.915861682764;4128.339465685476;4130.442390277319;4157;4157.646600039;4169.478815148106;3878.3019056569665;3949.0917089069676;4039.6768258539246;4156.812943417538;4182.163567286555;3695.981520092409;3698.6301369863068;3699.667029967316;3705.573859006222;3709.6104908984707;5107.719075450848;5119.257707632372;5122.154844450662;5125.333706618116;5132.871678208075;4815.422149342101;4829.782659780283;4830.130576496229;4832.371791667096;4834.709917404967;5517.144842549411;5629.971850140764;5644.887102257973;5649.180868774005;5650.830475085754;4046.8178931947837;4047.089404883907;4047.332190188615;4048.7165898387125;4050.06848424861;5937.2578427696535;5946.405359464062;5946.821595352147;5950.196723442323;5953.13679516472;4173.707840451139;4175.91648167035;4177.081042170717;4181.832726690898;4183.058811767389;4141.585841415835;4244.681648876347;4246.702730808814;4247.065645557972;4264.317709166518;4787.808487660454;4788.281757736368;4795.6163506919365;4797.7601119943865;4803.711777293373;5642.153676948408;5645.266115405053;5649.209110724501;5651.491365777099;5653.830385088454;1479.1347061968868;1509.7508911029777;1510.5241848817586;1511.6523199664139;1512.0322993284087;999.7153657550159;1039.6776999130293;1048.5858086056119;1051.6371851711147;1061.2730279758237;4958.7024778513405;4965.0318187953;4972.825951091694;4973.90052198954;4980.875478113004;5854.414558544197;5861.88276234473;5862.355140934494;5871.532116970758;5872.412758724094;4961.2806143109765;4969.981153863449;4971.4282857471135;4974.030064137531;4978.90042199154;2907.6656184539047;3001.294695746498;3110.860011299497;3139.6860313968878;3171.6035495563056;5509.944900551023;5580.246666700024;5589.35722391922;5592.7762889484775;5594.832155035356;6071.51427885768;6075.848103797441;6077;6082.2093127893095;6085.117657939662;5560.332760068818;5568.860778480489;5575.749091290902;5581.748821303051;5589.664620122724;5770.076787714113;5887.264091988502;5892.263467066617;5902.911456328073;5906.940930590639;5745.3105627324985;5748.338941021836;5751.482366587027;5759.366469688414;5759.769609215585;5568.610197286151;5569.331680198402;5574;5577.414371491097;5581.079121944996;4111.259973204852;4192.958070419257;4197.412362269346;4199.601037901394;4203.97898010508;5883.176355310175;5886.146508756292;5893.616914900518;5896.174535564938;5901.232839730807;5637.661740295595;5649.265595472562;5652.236948011966;5667.858303542444;5678.119891416837;5642.238297829905;5649.604527683023;5661.405552416937;5681.431856814285;5683.374828768915;5414.675119492843;5587.07813210832;5592.496675299242;5595.524380427709;5598.888022239614;5738.9139162913425;5740.512056475246;5744.334143098455;5745.540356771365;5750.482456578928;5380.784768609212;5495.642783219078;5504.834854954198;5508.641938274;5510.586705996986 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: |5;yui.html;802.7270727952495;804.0994086622983;808.5472135604066;812.3379445751712;828.4780588229413;11119.944400277998;11453.198276120675;11505.30968141911;11512.194146409754;11512.539498420054;11943.880561194386;13689.58931232062;13972.860271397283;13984.790228146561;14003.159810411382;630.5113537008809;632.7342516143208;794.4438892775051;799.656147856423;814.861473549495;796.4902462424053;797.4577287444536;805.5287656720825;805.5529181304373;805.556943680976;836.6277006732007;842.1115722912325;842.6250318608222;842.9968337678174;843.2537204573935;653.8724948635019;658.7793089315085;830.1325115254574;843.3337663246028;845.868890321995;622.2004723929774;622.9034499652515;624.2041397218537;624.4816802054283;625.543353352051;11366.772664546745;11482.712932176679;11492.770144597145;11502.309861408343;11518.308901465938;10619.41593212373;11162.330260184333;11167.664970050912;11437.885621143765;11520.942395288053;9231.492267925261;9353.532323383804;9413.341066125375;9497.192738617226;9525.523723813782;3180.8568614412175;3182.45898197307;3183.0450864740715;3253.3818574470774;3257.8533965971587;40433.39349909724;41029.38455923134;41063.7946810267;41213.58786412128;41228.793856030825;9423.38747981379;9496.952515237379;9667.226621870233;9699.127078562964;9738.318317717692;16163.919180404022;16275.10486923207;16333;16361.509154725378;16383.590410239602;6294.905576416358;6305.306416294204;6338.904916426257;6453.354664533509;6573.671316434159;3561.465780133001;3569.4110471772387;3650.8357123929486;3675.9632403676155;3684.852605895734;2718.5242582547976;2742.5200589897086;2745.258780129394;2748.4640495103263;2748.6564179477564;476.6877695109709;482.52471315753957;485.4150748348232;485.55329097230634;492.59853219625893;455.59679683480357;470.8422678402773;530.4350866327349;596.1445325957178;614.1279383275759;7488.251174882577;7694.461387702807;7714.4599878008;7867.537867537822;8211.917880821115;483.99812388355764;498.99013900439905;541.4098632490526;599.838043728191;609.5946195779845;3858.1897801461446;4005.35914253718;4007.6793856491413;4064.634182923551;4126.731762435432;48350.27474587884;49365;49387.25919111216;49476.257856131466;49527.50472495301;44042.559574403844;44685.776571116934;44917.10165796666;45136.3229551557;45164.77417612957;40553.391699124535;41163.58836411657;41338.999999999396;41409.585904141175;41622.58377416248;8139.511629302261;8249.133840946613;8281.83436331282;8340.87488687658;8368.163183681583;30559.54160687547;30752.846235768677;30786.84606576953;31264.843675781474;31554.211144721565;36499;36622.26755464929;37595.2480950374;40099.1980160401;40463.393049103695;8733.659235954292;8858.379913406;9458.33791634579;9745.22038236925;9966.50167491637;10866.185036122164;10945.562177512811;11124.777504449703;11240.269382490113;11297.943510282395;10468.371897686164;10922.726931826768;11275.32348059119;11356.318620882774;11411.486483108447;10807;10817.188710846875;10866.402347870942;11355;11391.316521008766;10510.316829406063;10521.684349469528;10588.523516441932;10811.837822432828;10883.129349652167;8780.253678437404;8979.865302020606;9080.137386948494;9381.390209636353;9419;8724.56377181151;9172.587233574372;9242.584083716383;9269.397489163182;9282.410519136025 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1556 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311010008__endTimestamp 12:36:50 INFO - 2015-11-23 12:36:50,016 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,017 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:50 INFO - 2015-11-23 12:36:50,017 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:36:50 INFO - 2015-11-23 12:36:50,018 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,018 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4652.84 Median:4775.55 stddev:481.01 (10.1%) stddev-sans-first:455.36 12:36:50 INFO - 2015-11-23 12:36:50,018 DEBUG : BROWSER_OUTPUT: Values: 2622.8 2730.2 2733.7 2752.4 2760.0 4502.4 4637.0 4709.2 4761.5 4766.1 4618.3 4630.1 4659.5 4665.7 4667.3 4315.4 4336.5 4406.2 4413.2 4420.6 4168.1 4343.8 4383.5 4447.0 4477.7 4235.2 4259.7 4315.9 4319.1 4338.0 4353.8 4355.6 4364.8 4376.7 4391.1 4168.8 4260.0 4338.4 4341.8 4387.8 4524.6 4548.8 4607.3 4639.0 4652.2 5113.9 5132.6 5138.8 5139.2 5168.9 4880.7 5153.6 5159.3 5161.0 5161.2 4643.2 4683.9 4691.4 4701.1 4751.8 5208.9 5219.0 5223.1 5226.0 5228.8 4774.4 5005.0 5018.3 5020.6 5067.1 4982.7 4983.9 4997.6 5080.3 5121.7 5078.2 5101.5 5104.7 5106.5 5148.3 5056.0 5064.8 5067.8 5070.9 5071.1 4042.0 4108.3 4136.1 4142.8 4218.3 3726.1 3726.3 3739.1 3757.9 3765.1 4404.6 4408.8 4415.0 4438.0 4443.3 4778.9 4882.9 4891.8 5020.3 5123.6 4349.3 4390.4 4404.2 4410.5 4438.0 4526.5 4528.5 4528.8 4532.5 4576.9 4630.1 4732.6 4736.7 4868.3 4868.7 4630.8 4940.5 5003.9 5017.8 5027.1 4853.5 4873.0 4873.7 4874.2 4920.2 4775.5 4877.0 4883.3 5068.6 5109.6 4922.4 4959.5 4963.0 4983.4 4985.0 4790.6 4797.7 4797.9 4834.4 4932.7 4871.1 4875.0 4875.0 4886.8 4980.5 4738.4 4778.3 4779.8 4816.3 4824.8 4726.1 4783.8 4799.1 4838.2 4908.6 4871.7 4875.4 4881.3 4900.6 4906.3 12:36:50 INFO - 2015-11-23 12:36:50,018 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,018 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42367.75 Median:31617.26 stddev:69346.19 (219.3%) stddev-sans-first:69469.67 12:36:50 INFO - 2015-11-23 12:36:50,019 DEBUG : BROWSER_OUTPUT: Values: 560.4 567.0 572.3 574.9 584.7 28718.6 29400.0 35040.5 35635.6 35711.0 41288.1 41735.2 41814.6 41937.9 41943.6 7018.8 7940.6 8110.6 8145.0 8148.8 7128.1 7202.7 7236.3 7238.6 9789.7 9985.7 10165.1 10185.3 10196.1 10202.7 10041.0 10141.2 10196.8 10198.2 10201.9 7172.9 7384.9 10087.6 10487.7 10511.5 36585.5 36935.4 37044.3 37045.3 37172.3 2975.0 3002.9 3024.2 3480.6 3585.5 28585.6 28828.6 28913.5 29025.0 29247.7 3352.5 3365.7 3385.4 3440.9 3510.2 231711.0 232202.0 232368.0 232531.8 232572.0 52898.5 54145.0 56654.0 60785.0 62856.0 57558.0 57572.4 57789.1 57824.0 57985.4 12356.9 12556.6 12563.4 12581.2 12584.2 9156.8 9199.5 9230.8 9247.4 9337.8 19176.4 19416.8 19558.7 19565.0 19584.6 7289.5 7545.5 7567.4 7599.2 7658.2 822.0 822.2 975.1 1008.7 1056.7 26677.5 26922.5 27129.5 27198.7 27833.2 943.8 948.0 988.4 1010.2 1025.5 13543.1 13603.3 13795.3 13827.4 13843.9 288626.0 294009.0 294523.0 295228.0 295264.0 47186.3 47284.8 47313.8 47373.0 47382.8 1160.4 1162.6 1182.2 1195.1 1196.1 25299.9 25638.4 26219.2 26320.3 26335.3 41637.6 41984.6 42066.8 42103.4 42190.6 265009.0 266290.0 267695.0 268214.0 268743.0 25247.9 25750.0 28961.7 29135.3 29260.3 39131.2 39543.2 39611.2 39922.0 40100.4 32935.7 33126.8 33781.7 34314.5 34405.5 25205.9 32864.0 33544.5 34633.3 35246.3 25842.5 26091.7 31227.4 31604.5 31630.0 24560.5 29779.3 30639.0 30808.8 30986.5 23142.8 24060.9 24067.6 24426.5 25860.6 12:36:50 INFO - 2015-11-23 12:36:50,019 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,019 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26007.10 Median:43246.78 stddev:79697.20 (184.3%) stddev-sans-first:79897.43 12:36:50 INFO - 2015-11-23 12:36:50,019 DEBUG : BROWSER_OUTPUT: Values: 319.8 324.3 337.6 340.4 340.8 11900.2 12286.3 14738.0 15222.0 15230.2 13425.8 13846.1 14105.2 14651.7 14668.9 4596.6 4856.0 5030.1 5034.1 5842.1 3608.9 3702.4 5473.1 5679.1 5739.7 5736.5 5774.0 5784.1 5786.4 5812.2 5581.7 5717.9 5728.7 5737.7 5738.1 4997.7 5019.1 5028.8 5042.0 5042.4 19098.5 19111.0 19317.3 19835.0 19854.2 1925.9 2018.0 2028.9 2029.1 2039.2 12828.1 12854.5 12886.8 13055.7 13148.4 1617.7 1622.3 1680.9 1687.8 1763.4 52765.7 53614.7 54681.5 54879.5 56254.4 9156.9 9301.0 9543.0 9558.7 9604.7 12113.9 12120.9 12121.9 12125.0 12127.4 6628.6 6636.4 6690.2 6694.2 6715.0 6121.1 6174.3 6197.5 6206.3 6215.9 5660.9 5712.5 5717.6 5742.9 5767.4 1527.7 1622.8 1624.9 1634.3 1693.1 775.4 873.8 912.5 958.8 1021.2 14815.9 15229.7 15511.1 15902.6 16503.6 753.9 823.3 844.3 855.6 928.5 8477.3 8648.3 8745.3 8992.1 9121.0 468549.0 490638.0 492725.0 493284.0 495217.0 67059.0 67973.0 69105.7 69320.3 70271.0 1069.6 1077.4 1085.7 1086.3 1087.8 13845.4 13922.9 13946.4 14028.3 14191.9 31161.4 31953.2 32033.0 32266.0 32563.0 41623.4 42983.0 43510.6 43745.8 44284.0 8648.1 9041.5 9048.4 9054.9 9291.8 10464.2 10505.3 10533.1 11188.3 15694.4 12978.7 13320.6 13572.3 13808.7 14149.8 4259.3 7568.0 12688.9 13550.7 13559.0 10889.6 11198.6 13647.9 13817.4 13902.1 8278.4 8554.6 8641.8 8664.0 8877.8 8794.0 8864.0 8864.9 11604.0 12269.7 12:36:50 INFO - 2015-11-23 12:36:50,019 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,020 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4692.66 Median:5770.90 stddev:2309.79 (40.0%) stddev-sans-first:2301.93 12:36:50 INFO - 2015-11-23 12:36:50,020 DEBUG : BROWSER_OUTPUT: Values: 1269.6 1655.9 1675.0 1706.3 1725.0 5605.0 6432.7 6708.4 6722.7 6724.0 6583.0 6675.2 6684.0 6687.7 6695.3 2063.3 2077.0 2081.6 2081.7 2083.7 2063.5 2083.1 2091.0 2107.5 2108.5 2026.1 2050.0 2050.5 2059.8 2061.3 2021.2 2032.7 2038.6 2043.3 2045.6 2034.3 2034.8 2073.0 2077.3 2082.0 5516.2 5695.1 6571.5 6606.5 6627.7 3828.1 3915.1 3922.0 3939.7 3954.9 2660.0 2711.8 2751.0 2763.6 2777.1 757.2 787.4 864.2 882.7 883.2 8528.1 8539.5 8555.7 8559.3 8575.2 3795.0 3799.5 3868.8 3941.7 3959.8 7649.5 7658.0 7662.9 7666.0 7679.9 4131.9 4142.4 4143.0 4146.3 4150.2 3773.4 3776.5 3781.1 3781.3 3785.4 3250.6 3268.4 3297.6 3300.9 3302.0 1069.7 1084.3 1088.0 1091.7 1095.6 1131.0 1148.4 1168.6 1176.3 1193.3 6371.9 6378.5 6402.4 6408.6 6419.3 995.1 1009.5 1022.7 1034.0 1040.0 5017.2 5020.3 5047.4 5063.5 5065.5 7186.2 7630.3 7646.0 7896.8 7897.1 7279.1 7665.3 7804.4 7823.8 7893.1 6185.7 6318.7 6321.2 6323.5 6327.1 6232.1 6318.0 6323.4 6325.1 6329.9 6982.9 7185.2 7237.9 7258.1 7293.2 7217.0 7289.1 7431.8 7434.3 7501.5 5939.5 6000.5 6006.1 6011.8 6014.4 6440.1 6488.1 6491.6 6496.4 6512.0 5941.3 5989.6 6001.5 6006.3 6209.5 5811.2 5835.5 5856.2 5882.6 5883.2 6133.1 6152.4 6155.4 6177.8 6178.0 5683.6 5690.3 5704.2 5765.8 5776.0 5434.1 5466.5 5471.9 5477.8 5488.4 12:36:50 INFO - 2015-11-23 12:36:50,021 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,021 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4709.87 Median:5301.56 stddev:1371.04 (25.9%) stddev-sans-first:1334.45 12:36:50 INFO - 2015-11-23 12:36:50,021 DEBUG : BROWSER_OUTPUT: Values: 306.4 307.6 313.0 316.3 319.4 5265.5 5314.9 5361.0 5364.9 5376.5 5299.6 5303.5 5310.7 5312.2 5322.8 3927.3 4006.2 4199.7 4204.4 4204.5 4075.4 4134.4 4199.6 4206.7 4206.9 4128.3 4130.4 4157.0 4157.6 4169.5 3878.3 3949.1 4039.7 4156.8 4182.2 3696.0 3698.6 3699.7 3705.6 3709.6 5107.7 5119.3 5122.2 5125.3 5132.9 4815.4 4829.8 4830.1 4832.4 4834.7 5517.1 5630.0 5644.9 5649.2 5650.8 4046.8 4047.1 4047.3 4048.7 4050.1 5937.3 5946.4 5946.8 5950.2 5953.1 4173.7 4175.9 4177.1 4181.8 4183.1 4141.6 4244.7 4246.7 4247.1 4264.3 4787.8 4788.3 4795.6 4797.8 4803.7 5642.2 5645.3 5649.2 5651.5 5653.8 1479.1 1509.8 1510.5 1511.7 1512.0 999.7 1039.7 1048.6 1051.6 1061.3 4958.7 4965.0 4972.8 4973.9 4980.9 5854.4 5861.9 5862.4 5871.5 5872.4 4961.3 4970.0 4971.4 4974.0 4978.9 2907.7 3001.3 3110.9 3139.7 3171.6 5509.9 5580.2 5589.4 5592.8 5594.8 6071.5 6075.8 6077.0 6082.2 6085.1 5560.3 5568.9 5575.7 5581.7 5589.7 5770.1 5887.3 5892.3 5902.9 5906.9 5745.3 5748.3 5751.5 5759.4 5759.8 5568.6 5569.3 5574.0 5577.4 5581.1 4111.3 4193.0 4197.4 4199.6 4204.0 5883.2 5886.1 5893.6 5896.2 5901.2 5637.7 5649.3 5652.2 5667.9 5678.1 5642.2 5649.6 5661.4 5681.4 5683.4 5414.7 5587.1 5592.5 5595.5 5598.9 5738.9 5740.5 5744.3 5745.5 5750.5 5380.8 5495.6 5504.8 5508.6 5510.6 12:36:50 INFO - 2015-11-23 12:36:50,021 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,021 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12280.03 Median:463.22 stddev:13763.75 (2971.3%) stddev-sans-first:13775.38 12:36:50 INFO - 2015-11-23 12:36:50,022 DEBUG : BROWSER_OUTPUT: Values: 802.7 804.1 808.5 812.3 828.5 11119.9 11453.2 11505.3 11512.2 11512.5 11943.9 13689.6 13972.9 13984.8 14003.2 630.5 632.7 794.4 799.7 814.9 796.5 797.5 805.5 805.6 805.6 836.6 842.1 842.6 843.0 843.3 653.9 658.8 830.1 843.3 845.9 622.2 622.9 624.2 624.5 625.5 11366.8 11482.7 11492.8 11502.3 11518.3 10619.4 11162.3 11167.7 11437.9 11520.9 9231.5 9353.5 9413.3 9497.2 9525.5 3180.9 3182.5 3183.0 3253.4 3257.9 40433.4 41029.4 41063.8 41213.6 41228.8 9423.4 9497.0 9667.2 9699.1 9738.3 16163.9 16275.1 16333.0 16361.5 16383.6 6294.9 6305.3 6338.9 6453.4 6573.7 3561.5 3569.4 3650.8 3676.0 3684.9 2718.5 2742.5 2745.3 2748.5 2748.7 476.7 482.5 485.4 485.6 492.6 455.6 470.8 530.4 596.1 614.1 7488.3 7694.5 7714.5 7867.5 8211.9 484.0 499.0 541.4 599.8 609.6 3858.2 4005.4 4007.7 4064.6 4126.7 48350.3 49365.0 49387.3 49476.3 49527.5 44042.6 44685.8 44917.1 45136.3 45164.8 40553.4 41163.6 41339.0 41409.6 41622.6 8139.5 8249.1 8281.8 8340.9 8368.2 30559.5 30752.8 30786.8 31264.8 31554.2 36499.0 36622.3 37595.2 40099.2 40463.4 8733.7 8858.4 9458.3 9745.2 9966.5 10866.2 10945.6 11124.8 11240.3 11297.9 10468.4 10922.7 11275.3 11356.3 11411.5 10807.0 10817.2 10866.4 11355.0 11391.3 10510.3 10521.7 10588.5 10811.8 10883.1 8780.3 8979.9 9080.1 9381.4 9419.0 8724.6 9172.6 9242.6 9269.4 9282.4 12:36:50 INFO - 2015-11-23 12:36:50,023 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:50 INFO - 2015-11-23 12:36:50,023 DEBUG : BROWSER_OUTPUT: 12:36:50 INFO - 2015-11-23 12:36:50,723 INFO : Browser exited with error code: 0 12:36:50 INFO - 2015-11-23 12:36:50,739 INFO : Completed test dromaeo_css (00:18:38) 12:36:50 INFO - 2015-11-23 12:36:50,739 INFO : Starting test kraken 12:36:50 INFO - 2015-11-23 12:36:50,739 DEBUG : operating with platform_type : linux_ 12:36:50 INFO - 2015-11-23 12:36:50,740 INFO : Initialising browser for kraken test... 12:36:50 INFO - 2015-11-23 12:36:50,746 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT4KbVS/profile http://localhost:49507/getInfo.html 12:36:54 INFO - 2015-11-23 12:36:54,782 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:54 INFO - 2015-11-23 12:36:54,782 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:54 INFO - 2015-11-23 12:36:54,782 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:54 INFO - 2015-11-23 12:36:54,783 DEBUG : BROWSER_OUTPUT: __metrics 12:36:54 INFO - 2015-11-23 12:36:54,851 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:56 INFO - 2015-11-23 12:36:56,265 INFO : Browser initialized. 12:36:56 INFO - 2015-11-23 12:36:56,266 INFO : Running cycle 1/1 for kraken test... 12:36:56 INFO - 2015-11-23 12:36:56,266 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpT4KbVS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:37:08 INFO - 2015-11-23 12:37:08,194 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 12:37:08 INFO - 2015-11-23 12:37:08,194 DEBUG : BROWSER_OUTPUT: 12:37:10 INFO - 2015-11-23 12:37:10,809 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49507/tests/kraken/driver.html?testName=audio-beat-detection) 12:37:11 INFO - 2015-11-23 12:37:11,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 174624768 12:37:11 INFO - 2015-11-23 12:37:11,395 DEBUG : BROWSER_OUTPUT: 12:37:14 INFO - 2015-11-23 12:37:14,113 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49507/tests/kraken/driver.html?testName=audio-dft) 12:37:14 INFO - 2015-11-23 12:37:14,694 DEBUG : BROWSER_OUTPUT: RSS: Main: 165294080 12:37:14 INFO - 2015-11-23 12:37:14,694 DEBUG : BROWSER_OUTPUT: 12:37:17 INFO - 2015-11-23 12:37:17,702 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49507/tests/kraken/driver.html?testName=audio-fft) 12:37:18 INFO - 2015-11-23 12:37:18,267 DEBUG : BROWSER_OUTPUT: RSS: Main: 150876160 12:37:18 INFO - 2015-11-23 12:37:18,267 DEBUG : BROWSER_OUTPUT: 12:37:20 INFO - 2015-11-23 12:37:20,300 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49507/tests/kraken/driver.html?testName=audio-oscillator) 12:37:20 INFO - 2015-11-23 12:37:20,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 153776128 12:37:20 INFO - 2015-11-23 12:37:20,881 DEBUG : BROWSER_OUTPUT: 12:37:23 INFO - 2015-11-23 12:37:23,054 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49507/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:37:23 INFO - 2015-11-23 12:37:23,627 DEBUG : BROWSER_OUTPUT: RSS: Main: 156233728 12:37:23 INFO - 2015-11-23 12:37:23,628 DEBUG : BROWSER_OUTPUT: 12:37:26 INFO - 2015-11-23 12:37:26,606 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49507/tests/kraken/driver.html?testName=imaging-darkroom) 12:37:27 INFO - 2015-11-23 12:37:27,188 DEBUG : BROWSER_OUTPUT: RSS: Main: 155582464 12:37:27 INFO - 2015-11-23 12:37:27,188 DEBUG : BROWSER_OUTPUT: 12:37:30 INFO - 2015-11-23 12:37:30,629 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49507/tests/kraken/driver.html?testName=imaging-desaturate) 12:37:31 INFO - 2015-11-23 12:37:31,211 DEBUG : BROWSER_OUTPUT: RSS: Main: 156839936 12:37:31 INFO - 2015-11-23 12:37:31,211 DEBUG : BROWSER_OUTPUT: 12:37:34 INFO - 2015-11-23 12:37:34,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49507/tests/kraken/driver.html?testName=json-parse-financial) 12:37:34 INFO - 2015-11-23 12:37:34,631 DEBUG : BROWSER_OUTPUT: RSS: Main: 155918336 12:37:34 INFO - 2015-11-23 12:37:34,631 DEBUG : BROWSER_OUTPUT: 12:37:36 INFO - 2015-11-23 12:37:36,352 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49507/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:37:36 INFO - 2015-11-23 12:37:36,913 DEBUG : BROWSER_OUTPUT: RSS: Main: 166064128 12:37:36 INFO - 2015-11-23 12:37:36,914 DEBUG : BROWSER_OUTPUT: 12:37:38 INFO - 2015-11-23 12:37:38,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:37:39 INFO - 2015-11-23 12:37:39,378 DEBUG : BROWSER_OUTPUT: RSS: Main: 165482496 12:37:39 INFO - 2015-11-23 12:37:39,378 DEBUG : BROWSER_OUTPUT: 12:37:41 INFO - 2015-11-23 12:37:41,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:37:42 INFO - 2015-11-23 12:37:42,071 DEBUG : BROWSER_OUTPUT: RSS: Main: 170098688 12:37:42 INFO - 2015-11-23 12:37:42,072 DEBUG : BROWSER_OUTPUT: 12:37:44 INFO - 2015-11-23 12:37:44,546 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:37:45 INFO - 2015-11-23 12:37:45,133 DEBUG : BROWSER_OUTPUT: RSS: Main: 178524160 12:37:45 INFO - 2015-11-23 12:37:45,133 DEBUG : BROWSER_OUTPUT: 12:37:47 INFO - 2015-11-23 12:37:47,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:37:48 INFO - 2015-11-23 12:37:48,301 DEBUG : BROWSER_OUTPUT: RSS: Main: 178728960 12:37:48 INFO - 2015-11-23 12:37:48,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49507/tests/kraken/driver.html?testName=ai-astar) 12:37:50 INFO - 2015-11-23 12:37:50,294 DEBUG : BROWSER_OUTPUT: RSS: Main: 235696128 12:37:50 INFO - 2015-11-23 12:37:50,294 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,294 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:50 INFO - 2015-11-23 12:37:50,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:50 INFO - 2015-11-23 12:37:50,294 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;114;107;113;115;111;102;111;103;113 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;153;135;152;164;136;153;160;132;169;131 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;159;162;161;161;162;162;163;162 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;74;83;90;75;73;73;95;91;73 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;92;138;91;90;91;123;91;93;131 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;109;109;109;110;110;109;110;109 12:37:50 INFO - 2015-11-23 12:37:50,295 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;147;146;147;147;148;146;148;147 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;96;95;95;95;95;95 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;68;70;69;70;69;69;77;67;67 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;68;69;69;69;69;69;68;68 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;83;83;83;83;82;84;84;91 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;118;119;119;121;119;117;125;120;125 12:37:50 INFO - 2015-11-23 12:37:50,296 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;137;140;145;147;140;145;152;146;135 12:37:50 INFO - 2015-11-23 12:37:50,297 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;68;67;68;69;68;69;68;69;69 12:37:50 INFO - 2015-11-23 12:37:50,297 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:50 INFO - 2015-11-23 12:37:50,297 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:37:50 INFO - 2015-11-23 12:37:50,297 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,995 12:37:50 INFO - 2015-11-23 12:37:50,297 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:37:50 INFO - 2015-11-23 12:37:50,298 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311070288__endTimestamp 12:37:50 INFO - 2015-11-23 12:37:50,298 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,298 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:50 INFO - 2015-11-23 12:37:50,298 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:37:50 INFO - 2015-11-23 12:37:50,298 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.00 Median:112.00 stddev:4.52 (4.0%) stddev-sans-first:4.78 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: Values: 111.0 114.0 107.0 113.0 115.0 111.0 102.0 111.0 103.0 113.0 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.50 Median:153.00 stddev:13.99 (9.1%) stddev-sans-first:14.75 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: Values: 153.0 135.0 152.0 164.0 136.0 153.0 160.0 132.0 169.0 131.0 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,299 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.17 (0.7%) stddev-sans-first:1.22 12:37:50 INFO - 2015-11-23 12:37:50,300 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 159.0 162.0 161.0 161.0 162.0 162.0 163.0 162.0 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.00 Median:79.00 stddev:8.89 (11.3%) stddev-sans-first:9.07 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: Values: 73.0 74.0 83.0 90.0 75.0 73.0 73.0 95.0 91.0 73.0 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.20 Median:91.00 stddev:19.30 (21.2%) stddev-sans-first:20.04 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: Values: 92.0 92.0 138.0 91.0 90.0 91.0 123.0 91.0 93.0 131.0 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 109.0 109.0 109.0 110.0 110.0 109.0 110.0 109.0 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.00 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 147.0 146.0 147.0 147.0 148.0 146.0 148.0 147.0 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.10 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 12:37:50 INFO - 2015-11-23 12:37:50,301 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.40 Median:69.00 stddev:2.88 (4.2%) stddev-sans-first:3.00 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 70.0 69.0 70.0 69.0 69.0 77.0 67.0 67.0 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 68.0 68.0 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.70 Median:83.00 stddev:2.67 (3.2%) stddev-sans-first:2.76 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 83.0 83.0 83.0 83.0 82.0 84.0 84.0 91.0 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:120.40 Median:120.50 stddev:2.72 (2.3%) stddev-sans-first:2.87 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: Values: 121.0 118.0 119.0 119.0 121.0 119.0 117.0 125.0 120.0 125.0 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.30 Median:145.50 stddev:5.17 (3.5%) stddev-sans-first:5.39 12:37:50 INFO - 2015-11-23 12:37:50,302 DEBUG : BROWSER_OUTPUT: Values: 146.0 137.0 140.0 145.0 147.0 140.0 145.0 152.0 146.0 135.0 12:37:50 INFO - 2015-11-23 12:37:50,303 DEBUG : BROWSER_OUTPUT: 12:37:50 INFO - 2015-11-23 12:37:50,303 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:37:50 INFO - 2015-11-23 12:37:50,303 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 69.0 68.0 69.0 68.0 69.0 69.0 12:37:50 INFO - 2015-11-23 12:37:50,303 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:50 INFO - 2015-11-23 12:37:50,303 DEBUG : BROWSER_OUTPUT: 12:37:51 INFO - 2015-11-23 12:37:51,215 INFO : Browser exited with error code: 0 12:37:51 INFO - 2015-11-23 12:37:51,263 INFO : Completed test kraken (00:01:00) 12:37:51 INFO - 2015-11-23 12:37:51,263 INFO : Starting test v8_7 12:37:51 INFO - 2015-11-23 12:37:51,263 DEBUG : operating with platform_type : linux_ 12:37:51 INFO - 2015-11-23 12:37:51,263 INFO : Initialising browser for v8_7 test... 12:37:51 INFO - 2015-11-23 12:37:51,269 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprf7epN/profile http://localhost:49507/getInfo.html 12:37:55 INFO - 2015-11-23 12:37:55,212 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:37:55 INFO - 2015-11-23 12:37:55,212 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:37:55 INFO - 2015-11-23 12:37:55,212 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:37:55 INFO - 2015-11-23 12:37:55,212 DEBUG : BROWSER_OUTPUT: __metrics 12:37:55 INFO - 2015-11-23 12:37:55,389 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:37:56 INFO - 2015-11-23 12:37:56,639 INFO : Browser initialized. 12:37:56 INFO - 2015-11-23 12:37:56,639 INFO : Running cycle 1/1 for v8_7 test... 12:37:56 INFO - 2015-11-23 12:37:56,639 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprf7epN/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:38:08 INFO - 2015-11-23 12:38:08,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 139788288 12:38:08 INFO - 2015-11-23 12:38:08,519 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,007 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49507/tests/v8_7/run.html (next: http://localhost:49507/tests/v8_7/run.html) 12:38:30 INFO - 2015-11-23 12:38:30,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 444706816 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:38:30 INFO - 2015-11-23 12:38:30,258 DEBUG : BROWSER_OUTPUT: |0;Richards;162.65452179570593 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.43904335990666 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.06271379703537 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5133.333333333333 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2012.0724346076458 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |5;Earley;798.0845969672786 12:38:30 INFO - 2015-11-23 12:38:30,259 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: |7;RegExp;26657.894736842107 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: |8;Splay;589.2751915144372 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311110256__endTimestamp 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:38:30 INFO - 2015-11-23 12:38:30,260 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.65 Median:162.65 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: Values: 162.7 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.44 Median:194.44 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: Values: 194.4 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.06 Median:285.06 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,261 DEBUG : BROWSER_OUTPUT: Values: 285.1 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5133.33 Median:5133.33 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: Values: 5133.3 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2012.07 Median:2012.07 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: Values: 2012.1 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,262 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:798.08 Median:798.08 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,263 DEBUG : BROWSER_OUTPUT: Values: 798.1 12:38:30 INFO - 2015-11-23 12:38:30,263 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,263 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,263 DEBUG : BROWSER_OUTPUT: Values: 12219.5 12:38:30 INFO - 2015-11-23 12:38:30,263 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26657.89 Median:26657.89 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: Values: 26657.9 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:589.28 Median:589.28 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: Values: 589.3 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: Values: 4830.9 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:38:30 INFO - 2015-11-23 12:38:30,264 DEBUG : BROWSER_OUTPUT: 12:38:31 INFO - 2015-11-23 12:38:31,195 INFO : Browser exited with error code: 0 12:38:31 INFO - 2015-11-23 12:38:31,210 INFO : Completed test v8_7 (00:00:39) 12:38:31 INFO - 2015-11-23 12:38:31,700 INFO : Completed test suite (00:20:19) 12:38:31 INFO - 2015-11-23 12:38:31,700 DEBUG : Working with test: dromaeo_css 12:38:31 INFO - 2015-11-23 12:38:31,700 DEBUG : Generating results file: dromaeo_css 12:38:31 INFO - 2015-11-23 12:38:31,701 DEBUG : Working with test: kraken 12:38:31 INFO - 2015-11-23 12:38:31,701 DEBUG : Generating results file: kraken 12:38:31 INFO - 2015-11-23 12:38:31,701 INFO : javascript benchmark 12:38:31 INFO - 2015-11-23 12:38:31,702 DEBUG : Working with test: v8_7 12:38:31 INFO - 2015-11-23 12:38:31,702 DEBUG : Generating results file: v8_7 12:38:31 INFO - 2015-11-23 12:38:31,702 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:31 INFO - 2015-11-23 12:38:31,747 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:38:31 INFO - 2015-11-23 12:38:31,747 DEBUG : process_Request line: dromaeo_css 6298.95 graph.html#tests=[[72,132,35]] 12:38:31 INFO - 2015-11-23 12:38:31,747 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:31 INFO - 2015-11-23 12:38:31,774 DEBUG : process_Request line: kraken 1508.40 graph.html#tests=[[232,132,35]] 12:38:31 INFO - 2015-11-23 12:38:31,774 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:38:31 INFO - 2015-11-23 12:38:31,806 DEBUG : process_Request line: v8_7 19750.36 graph.html#tests=[[230,132,35]] 12:38:31 INFO - 2015-11-23 12:38:31,807 INFO : javascript benchmark 12:38:31 INFO - 2015-11-23 12:38:31,811 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.842629442233, 2730.208239610513, 2733.726627337265, 2752.40823223007, 2759.9999999999995, 4502.414686090804, 4636.976815115928, 4709.222978208596, 4761.50004249554, 4766.142094423002, 4618.261078227484, 4630.12027714734, 4659.487456379796, 4665.743384113873, 4667.276572131316, 4315.374270730742, 4336.457942757155, 4406.184855801687, 4413.249747542925, 4420.602145806877, 4168.1038576706005, 4343.826246950134, 4383.517813040563, 4446.955530444703, 4477.70894891831, 4235.216484950294, 4259.6805239607, 4315.935260971088, 4319.1361727654285, 4337.97831010846, 4353.847615333448, 4355.5644435556505, 4364.847230346954, 4376.6936314458, 4391.143726973241, 4168.812403441852, 4260.0414906646065, 4338.370936214263, 4341.848035318749, 4387.758673272969, 4524.5701658342405, 4548.7725613719185, 4607.331936869169, 4638.976805115986, 4652.185867473178, 5113.948860511385, 5132.563732082777, 5138.820141295037, 5139.177731562932, 5168.870778230536, 4880.707157570557, 5153.613478989053, 5159.329287192679, 5161.045206636784, 5161.225816127573, 4643.164230438553, 4683.88290292742, 4691.437027556681, 4701.106789709944, 4751.762411879392, 5208.8958220835375, 5219.0, 5223.112070947948, 5226.033183860998, 5228.764705588258, 4774.379330686988, 5004.973980334023, 5018.2974383586325, 5020.573251273682, 5067.087924173684, 4982.701037937735, 4983.875403114951, 4997.575206107449, 5080.314157588678, 5121.718305493234, 5078.238264260391, 5101.464346243591, 5104.693718376835, 5106.489351064938, 5148.304978827885, 5056.0, 5064.822731204464, 5067.797288108508, 5070.949290507121, 5071.0872043032605, 4041.9797901010893, 4108.342665173558, 4136.110736191733, 4142.834286628501, 4218.261804184255, 3726.1057346236707, 3726.2920045191327, 3739.102615372291, 3757.9436308455397, 3765.058735316171, 4404.581564751344, 4408.801603927767, 4414.977925110354, 4438.0, 4443.289073748185, 4778.880527986828, 4882.853514394574, 4891.779869905863, 5020.347354843847, 5123.615728820353, 4349.3041113421705, 4390.385346051556, 4404.207242696281, 4410.470743510799, 4438.045820148684, 4526.502084770673, 4528.47922488918, 4528.841490547815, 4532.524084971096, 4576.931346029813, 4630.120277147331, 4732.645051621211, 4736.739479328532, 4868.269759536027, 4868.707877527359, 4630.791614377294, 4940.505949405031, 5003.949960500348, 5017.799288028584, 5027.145385284583, 4853.466118727008, 4873.025394920959, 4873.6832105913, 4874.171390863491, 4920.21276595743, 4775.5463230993, 4876.951230487792, 4883.316335712932, 5068.619853511075, 5109.616778741535, 4922.4339200992345, 4959.454460009469, 4962.950370496394, 4983.352164218629, 4984.975075124601, 4790.592799612072, 4797.736124513046, 4797.880052998564, 4834.395700537433, 4932.679375840559, 4871.128632440388, 4875.0, 4875.04936537386, 4886.828960986349, 4980.526849949249, 4738.360321356573, 4778.307145463958, 4779.808807647794, 4816.301636262652, 4824.831130910401, 4726.1020406122725, 4783.832565860178, 4799.136155492045, 4838.177509823268, 4908.631852610997, 4871.732054737024, 4875.390576177978, 4881.292212629078, 4900.583450406612, 4906.3376444181], "unit": "ms", "name": "dojo.html", "value": 4623.498751674723}, {"lowerIsBetter": false, "replicates": [560.3751816724352, 567.0416995277983, 572.3132241310427, 574.9195112684222, 584.7456356484927, 28718.56922146167, 29400.0, 35040.47439288413, 35635.643643563555, 35711.0, 41288.142033608485, 41735.165296694046, 41814.581854181524, 41937.85466090048, 41943.58056419435, 7018.824529386755, 7940.6029698514985, 8110.594470276492, 8145.0, 8148.75553733386, 7128.108986376703, 7202.675879585405, 7236.348728614424, 7238.601876896769, 9789.706308810748, 9985.700428987142, 10165.085142337188, 10185.337953033066, 10196.133328667072, 10202.744931376701, 10041.04610062043, 10141.239407044464, 10196.847047294297, 10198.235132365102, 10201.897981020169, 7172.892406613905, 7384.926150738477, 10087.646932357406, 10487.73780655482, 10511.474426278655, 36585.45121823175, 36935.445968310494, 37044.259114817825, 37045.25909481822, 37172.25655486875, 2975.0, 3002.9249268768235, 3024.21370443684, 3480.564929383827, 3585.480105384731, 28585.57121643177, 28828.567571486445, 28913.54234890016, 29025.0, 29247.707522924924, 3352.4534133801058, 3365.7475689323155, 3385.373705864423, 3440.8623655053766, 3510.1751088494184, 231711.0, 232202.0, 232368.0, 232531.83734081392, 232572.0, 52898.471015290124, 54145.0, 56654.0, 60785.0, 62856.0, 57558.0, 57572.424275756704, 57789.13316300259, 57824.0, 57985.420145798846, 12356.876431235572, 12556.623301300975, 12563.371831408393, 12581.182223155465, 12584.18202816814, 9156.816863662689, 9199.540022998823, 9230.769230769285, 9247.352685311964, 9337.766555836159, 19176.389089622393, 19416.80858056219, 19558.70661940072, 19565.0, 19584.608307833765, 7289.489735718449, 7545.50954187987, 7567.394608431312, 7599.164091949881, 7658.157602663702, 821.9958900205461, 822.173715416015, 975.1077763846001, 1008.6570566007446, 1056.6988408303596, 26677.466450671265, 26922.461550769265, 27129.45741085167, 27198.72801271962, 27833.16500504988, 943.834828904939, 948.0466454883153, 988.3526290279879, 1010.1565193063874, 1025.5231317437429, 13543.119697219847, 13603.251821149932, 13795.310234488235, 13827.377768000464, 13843.861561384258, 288626.0, 294009.0, 294523.0, 295228.0, 295264.0, 47186.29220561694, 47284.76357618259, 47313.763431182626, 47373.0, 47382.76308618435, 1160.3733983648904, 1162.5756598841363, 1182.196106647488, 1195.0917302849723, 1196.1029228078942, 25299.873500633115, 25638.359041023377, 26219.21342359732, 26320.34199145037, 26335.34161645974, 41637.58362416337, 41984.58015419807, 42066.789666051474, 42103.36844947389, 42190.57809421989, 265009.0, 266290.0, 267695.0, 268214.0, 268743.0, 25247.87376063108, 25750.0, 28961.7103828959, 29135.271618209714, 29260.268493287836, 39131.217375652894, 39543.20913581655, 39611.2077758449, 39922.0, 40100.39849402203, 32935.67064329326, 33126.80545871122, 33781.66218337785, 34314.48528272128, 34405.483917740756, 25205.87397063003, 32864.0, 33544.49683254704, 34633.30733385268, 35246.29507409889, 25842.483150337262, 26091.739082608932, 31227.375452491277, 31604.525932111497, 31630.0, 24560.50878982446, 29779.255518612208, 30639.0, 30808.845955770976, 30986.535201972438, 23142.76857231406, 24060.87969560211, 24067.638985414884, 24426.51146977015, 25860.612090819028], "unit": "ms", "name": "ext.html", "value": 17169.18686327459}, {"lowerIsBetter": false, "replicates": [319.7985269280353, 324.346441919532, 337.55779928293924, 340.4416756519307, 340.7887109991805, 11900.22648527845, 12286.324252166127, 14738.042027268233, 15222.0, 15230.238488075593, 13425.798613020812, 13846.100003499765, 14105.2242126683, 14651.706965860676, 14668.853311466883, 4596.6322694184555, 4856.0, 5030.06943715412, 5034.119029169899, 5842.0652695568715, 3608.9097772555633, 3702.4261239507787, 5473.0969390050595, 5679.148127780845, 5739.655620662774, 5736.483716465538, 5774.018416869121, 5784.074548072309, 5786.392428794979, 5812.244408226946, 5581.6930068846195, 5717.885642287172, 5728.742206600692, 5737.741801618937, 5738.139279108125, 4997.6501644884875, 5019.121653710586, 5028.823991160292, 5042.0, 5042.369703787027, 19098.522536936547, 19111.0, 19317.323893663655, 19835.0, 19854.20583176671, 1925.894075825829, 2018.0414303206007, 2028.949276268105, 2029.0564887327464, 2039.2454791727157, 12828.102032857703, 12854.485820567166, 12886.80669789954, 13055.738885222243, 13148.40832162555, 1617.7007253658112, 1622.2537632688977, 1680.8907421017595, 1687.7890263717036, 1763.374002229203, 52765.73617131928, 53614.73192634051, 54681.45318546843, 54879.451205488236, 56254.43745562533, 9156.8626470603, 9300.953495232481, 9542.952285238669, 9558.665446709332, 9604.66383676568, 12113.939430302968, 12120.878791212152, 12121.878781212252, 12125.029997600172, 12127.39363031845, 6628.635425051669, 6636.435902948207, 6690.163729533809, 6694.230163531256, 6714.966425167843, 6121.112438696364, 6174.320824709278, 6197.5351848611535, 6206.286277078104, 6215.906761398583, 5660.858478537987, 5712.542996560265, 5717.628354156966, 5742.885142297214, 5767.36558978512, 1527.7173722861305, 1622.7971503562055, 1624.894381865175, 1634.3054201964355, 1693.09419460588, 775.3835700618022, 873.8383399071192, 912.493566070837, 958.8178246133212, 1021.1728499915092, 14815.92592037033, 15229.695406092038, 15511.146886921102, 15902.602434938988, 16503.587410314838, 753.88691696246, 823.2549542663899, 844.2992316377515, 855.5807654249373, 928.5403725155955, 8477.321814254845, 8648.264897483785, 8745.344099192585, 8992.145746154105, 9121.0, 468549.0, 490638.0, 492725.0, 493284.0, 495217.0, 67059.0, 67973.0, 69105.65447172833, 69320.30679693239, 70271.0, 1069.5507288309684, 1077.4451157653814, 1085.6634443322596, 1086.28305318491, 1087.842262871895, 13845.428138732263, 13922.860771392156, 13946.372413241226, 14028.2985850705, 14191.858081419054, 31161.37677246488, 31953.201169970936, 32033.0, 32266.0, 32563.0, 41623.37564936589, 42983.0, 43510.56489435192, 43745.78127109344, 44284.0, 8648.135186481302, 9041.547922603711, 9048.41185322952, 9054.909450905407, 9291.814163716823, 10464.215183861088, 10505.266631006105, 10533.052025317758, 11188.328700278009, 15694.372225110868, 12978.67553311137, 13320.600381988555, 13572.253526055767, 13808.654783630489, 14149.787753183504, 4259.297215959456, 7568.0, 12688.936555317165, 13550.661490929302, 13559.0, 10889.564417423215, 11198.552057917917, 13647.931760341531, 13817.447302107803, 13902.096363736326, 8278.420510564203, 8554.615042323236, 8641.783955401166, 8664.0, 8877.822443551222, 8793.956030219808, 8864.0, 8864.86702699447, 11604.0, 12269.69325766863], "unit": "ms", "name": "jquery.html", "value": 8153.292548360421}, {"lowerIsBetter": false, "replicates": [1269.631806776035, 1655.884088113832, 1674.9581260468487, 1706.3004168291004, 1724.9568760780983, 5605.0, 6432.742690292389, 6708.396244338009, 6722.663866806664, 6723.966380168093, 6582.967085164568, 6675.231063768106, 6684.030815531745, 6687.665616719169, 6695.263521012685, 2063.277852751536, 2077.0237988145545, 2081.573277478121, 2081.698153767703, 2083.7291152150274, 2063.4531849060013, 2083.104265165978, 2091.0381224636685, 2107.546877421354, 2108.525581744103, 2026.1186383922966, 2049.9692504612444, 2050.5386288085137, 2059.7631272403714, 2061.288855344904, 2021.2319318658963, 2032.725582046427, 2038.5515186659059, 2043.2950632031925, 2045.5908818236264, 2034.257496013959, 2034.7761746207905, 2073.0, 2077.314486219544, 2082.0, 5516.172574113875, 5695.14572814077, 6571.539992200548, 6606.471482281406, 6627.73489060437, 3828.062124779419, 3915.138669492707, 3922.0, 3939.684825213976, 3954.8813535593977, 2660.0024990628513, 2711.7559419652325, 2750.972490275112, 2763.599278104684, 2777.1113243762006, 757.2008314362104, 787.3543694170725, 864.2178828160525, 882.6778225947482, 883.1742320929951, 8528.104549022388, 8539.530325832076, 8555.743327700178, 8559.27246184075, 8575.228229459317, 3794.962050379516, 3799.525059367579, 3868.787216703052, 3941.7043721720984, 3959.8416063357145, 7649.464537482434, 7658.0, 7662.9233707663325, 7666.041744781903, 7679.884801727979, 4131.876043718633, 4142.378643203544, 4142.958570414317, 4146.3158578834755, 4150.190712810973, 3773.396256598931, 3776.4524143999515, 3781.1303400217553, 3781.3193625147187, 3785.37541305687, 3250.6424293327714, 3268.4116858965613, 3297.554830097954, 3300.851461684182, 3302.0424077017874, 1069.652362982034, 1084.2789544952675, 1088.031651829872, 1091.6888686724246, 1095.6165342130191, 1130.9943450282697, 1148.385613696685, 1168.6085161470833, 1176.2942234659135, 1193.2780667696093, 6371.904421433682, 6378.521610879203, 6402.391772781578, 6408.583442076343, 6419.293877673452, 995.0894931138073, 1009.5255230041869, 1022.6676330192718, 1034.0, 1039.9948000259951, 5017.172166592544, 5020.297158397827, 5047.394312682502, 5063.468335824759, 5065.468125846806, 7186.173590037108, 7630.2751238632245, 7645.961770191114, 7896.763097107096, 7897.05235371759, 7279.05372301608, 7665.3101220890385, 7804.3756499479905, 7823.804404889809, 7893.052833659997, 6185.721642526097, 6318.7472501100365, 6321.209848768904, 6323.494120470351, 6327.050942358591, 6232.065190221503, 6318.0, 6323.430891219812, 6325.051242313506, 6329.936700633119, 6982.895256571257, 7185.173705023989, 7237.8914316284245, 7258.056452661121, 7293.197748247795, 7216.96391518039, 7289.052423184952, 7431.777046688608, 7434.293742094493, 7501.512401693873, 5939.46544810969, 6000.519958403404, 6006.129111278753, 6011.7595296187665, 6014.398560143951, 6440.066190402459, 6488.059231411325, 6491.578047426902, 6496.382843629847, 6512.0, 5941.31674857397, 5989.580729348903, 6001.459868611846, 6006.309274433496, 6209.472194863307, 5811.186433899173, 5835.4748072673665, 5856.238688970577, 5882.588218824641, 5883.176355310175, 6133.141360209664, 6152.384761523812, 6155.384461553809, 6177.84555386119, 6178.0, 5683.6305640134915, 5690.260266165372, 5704.229928959703, 5765.798197063083, 5776.0, 5434.10337294342, 5466.480684334982, 5471.932973070372, 5477.808276710296, 5488.368837583729], "unit": "ms", "name": "mootools.html", "value": 3931.7643235777655}, {"lowerIsBetter": false, "replicates": [306.35053686185285, 307.58629643129984, 312.968703129687, 316.2741508238592, 319.38677738741615, 5265.526102650761, 5314.867128321785, 5360.973195134028, 5364.892702145955, 5376.462353764621, 5299.576033917287, 5303.549198318147, 5310.70791106489, 5312.150055991042, 5322.8137015204475, 3927.3323534998976, 4006.2187873364705, 4199.68502362324, 4204.390363397306, 4204.516480604724, 4075.4294398784195, 4134.421181034658, 4199.643030342425, 4206.663466922654, 4206.915861682764, 4128.339465685476, 4130.442390277319, 4157.0, 4157.646600039, 4169.478815148106, 3878.3019056569665, 3949.0917089069676, 4039.6768258539246, 4156.812943417538, 4182.163567286555, 3695.981520092409, 3698.6301369863068, 3699.667029967316, 3705.573859006222, 3709.6104908984707, 5107.719075450848, 5119.257707632372, 5122.154844450662, 5125.333706618116, 5132.871678208075, 4815.422149342101, 4829.782659780283, 4830.130576496229, 4832.371791667096, 4834.709917404967, 5517.144842549411, 5629.971850140764, 5644.887102257973, 5649.180868774005, 5650.830475085754, 4046.8178931947837, 4047.089404883907, 4047.332190188615, 4048.7165898387125, 4050.06848424861, 5937.2578427696535, 5946.405359464062, 5946.821595352147, 5950.196723442323, 5953.13679516472, 4173.707840451139, 4175.91648167035, 4177.081042170717, 4181.832726690898, 4183.058811767389, 4141.585841415835, 4244.681648876347, 4246.702730808814, 4247.065645557972, 4264.317709166518, 4787.808487660454, 4788.281757736368, 4795.6163506919365, 4797.7601119943865, 4803.711777293373, 5642.153676948408, 5645.266115405053, 5649.209110724501, 5651.491365777099, 5653.830385088454, 1479.1347061968868, 1509.7508911029777, 1510.5241848817586, 1511.6523199664139, 1512.0322993284087, 999.7153657550159, 1039.6776999130293, 1048.5858086056119, 1051.6371851711147, 1061.2730279758237, 4958.7024778513405, 4965.0318187953, 4972.825951091694, 4973.90052198954, 4980.875478113004, 5854.414558544197, 5861.88276234473, 5862.355140934494, 5871.532116970758, 5872.412758724094, 4961.2806143109765, 4969.981153863449, 4971.4282857471135, 4974.030064137531, 4978.90042199154, 2907.6656184539047, 3001.294695746498, 3110.860011299497, 3139.6860313968878, 3171.6035495563056, 5509.944900551023, 5580.246666700024, 5589.35722391922, 5592.7762889484775, 5594.832155035356, 6071.51427885768, 6075.848103797441, 6077.0, 6082.2093127893095, 6085.117657939662, 5560.332760068818, 5568.860778480489, 5575.749091290902, 5581.748821303051, 5589.664620122724, 5770.076787714113, 5887.264091988502, 5892.263467066617, 5902.911456328073, 5906.940930590639, 5745.3105627324985, 5748.338941021836, 5751.482366587027, 5759.366469688414, 5759.769609215585, 5568.610197286151, 5569.331680198402, 5574.0, 5577.414371491097, 5581.079121944996, 4111.259973204852, 4192.958070419257, 4197.412362269346, 4199.601037901394, 4203.97898010508, 5883.176355310175, 5886.146508756292, 5893.616914900518, 5896.174535564938, 5901.232839730807, 5637.661740295595, 5649.265595472562, 5652.236948011966, 5667.858303542444, 5678.119891416837, 5642.238297829905, 5649.604527683023, 5661.405552416937, 5681.431856814285, 5683.374828768915, 5414.675119492843, 5587.07813210832, 5592.496675299242, 5595.524380427709, 5598.888022239614, 5738.9139162913425, 5740.512056475246, 5744.334143098455, 5745.540356771365, 5750.482456578928, 5380.784768609212, 5495.642783219078, 5504.834854954198, 5508.641938274, 5510.586705996986], "unit": "ms", "name": "prototype.html", "value": 4274.598910351325}, {"lowerIsBetter": false, "replicates": [802.7270727952495, 804.0994086622983, 808.5472135604066, 812.3379445751712, 828.4780588229413, 11119.944400277998, 11453.198276120675, 11505.30968141911, 11512.194146409754, 11512.539498420054, 11943.880561194386, 13689.58931232062, 13972.860271397283, 13984.790228146561, 14003.159810411382, 630.5113537008809, 632.7342516143208, 794.4438892775051, 799.656147856423, 814.861473549495, 796.4902462424053, 797.4577287444536, 805.5287656720825, 805.5529181304373, 805.556943680976, 836.6277006732007, 842.1115722912325, 842.6250318608222, 842.9968337678174, 843.2537204573935, 653.8724948635019, 658.7793089315085, 830.1325115254574, 843.3337663246028, 845.868890321995, 622.2004723929774, 622.9034499652515, 624.2041397218537, 624.4816802054283, 625.543353352051, 11366.772664546745, 11482.712932176679, 11492.770144597145, 11502.309861408343, 11518.308901465938, 10619.41593212373, 11162.330260184333, 11167.664970050912, 11437.885621143765, 11520.942395288053, 9231.492267925261, 9353.532323383804, 9413.341066125375, 9497.192738617226, 9525.523723813782, 3180.8568614412175, 3182.45898197307, 3183.0450864740715, 3253.3818574470774, 3257.8533965971587, 40433.39349909724, 41029.38455923134, 41063.7946810267, 41213.58786412128, 41228.793856030825, 9423.38747981379, 9496.952515237379, 9667.226621870233, 9699.127078562964, 9738.318317717692, 16163.919180404022, 16275.10486923207, 16333.0, 16361.509154725378, 16383.590410239602, 6294.905576416358, 6305.306416294204, 6338.904916426257, 6453.354664533509, 6573.671316434159, 3561.465780133001, 3569.4110471772387, 3650.8357123929486, 3675.9632403676155, 3684.852605895734, 2718.5242582547976, 2742.5200589897086, 2745.258780129394, 2748.4640495103263, 2748.6564179477564, 476.6877695109709, 482.52471315753957, 485.4150748348232, 485.55329097230634, 492.59853219625893, 455.59679683480357, 470.8422678402773, 530.4350866327349, 596.1445325957178, 614.1279383275759, 7488.251174882577, 7694.461387702807, 7714.4599878008, 7867.537867537822, 8211.917880821115, 483.99812388355764, 498.99013900439905, 541.4098632490526, 599.838043728191, 609.5946195779845, 3858.1897801461446, 4005.35914253718, 4007.6793856491413, 4064.634182923551, 4126.731762435432, 48350.27474587884, 49365.0, 49387.25919111216, 49476.257856131466, 49527.50472495301, 44042.559574403844, 44685.776571116934, 44917.10165796666, 45136.3229551557, 45164.77417612957, 40553.391699124535, 41163.58836411657, 41338.999999999396, 41409.585904141175, 41622.58377416248, 8139.511629302261, 8249.133840946613, 8281.83436331282, 8340.87488687658, 8368.163183681583, 30559.54160687547, 30752.846235768677, 30786.84606576953, 31264.843675781474, 31554.211144721565, 36499.0, 36622.26755464929, 37595.2480950374, 40099.1980160401, 40463.393049103695, 8733.659235954292, 8858.379913406, 9458.33791634579, 9745.22038236925, 9966.50167491637, 10866.185036122164, 10945.562177512811, 11124.777504449703, 11240.269382490113, 11297.943510282395, 10468.371897686164, 10922.726931826768, 11275.32348059119, 11356.318620882774, 11411.486483108447, 10807.0, 10817.188710846875, 10866.402347870942, 11355.0, 11391.316521008766, 10510.316829406063, 10521.684349469528, 10588.523516441932, 10811.837822432828, 10883.129349652167, 8780.253678437404, 8979.865302020606, 9080.137386948494, 9381.390209636353, 9419.0, 8724.56377181151, 9172.587233574372, 9242.584083716383, 9269.397489163182, 9282.410519136025], "unit": "ms", "name": "yui.html", "value": 5741.500751765117}], "name": "dromaeo_css", "value": 6298.948308937947}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 114.0, 107.0, 113.0, 115.0, 111.0, 102.0, 111.0, 103.0, 113.0], "unit": "ms", "name": "ai-astar", "value": 110.0}, {"lowerIsBetter": true, "replicates": [153.0, 135.0, 152.0, 164.0, 136.0, 153.0, 160.0, 132.0, 169.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.5}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 159.0, 162.0, 161.0, 161.0, 162.0, 162.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [73.0, 74.0, 83.0, 90.0, 75.0, 73.0, 73.0, 95.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 80.0}, {"lowerIsBetter": true, "replicates": [92.0, 92.0, 138.0, 91.0, 90.0, 91.0, 123.0, 91.0, 93.0, 131.0], "unit": "ms", "name": "audio-oscillator", "value": 103.2}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 109.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 147.0, 146.0, 147.0, 147.0, 148.0, 146.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.0}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 70.0, 69.0, 70.0, 69.0, 69.0, 77.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.4}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 83.0, 82.0, 84.0, 84.0, 91.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.7}, {"lowerIsBetter": true, "replicates": [121.0, 118.0, 119.0, 119.0, 121.0, 119.0, 117.0, 125.0, 120.0, 125.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 120.4}, {"lowerIsBetter": true, "replicates": [146.0, 137.0, 140.0, 145.0, 147.0, 140.0, 145.0, 152.0, 146.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.3}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1508.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.65452179570593], "unit": "score", "name": "Richards", "value": 217.03669599999998}, {"lowerIsBetter": false, "replicates": [194.43904335990666], "unit": "score", "name": "DeltaBlue", "value": 340.0448739999999}, {"lowerIsBetter": false, "replicates": [285.06271379703537], "unit": "score", "name": "Encrypt", "value": 933.7629479999997}, {"lowerIsBetter": false, "replicates": [5133.333333333333], "unit": "score", "name": "Decrypt", "value": 51.85344155844158}, {"lowerIsBetter": false, "replicates": [2012.0724346076458], "unit": "score", "name": "RayTrace", "value": 367.77453300000013}, {"lowerIsBetter": false, "replicates": [798.0845969672786], "unit": "score", "name": "Earley", "value": 835.078139}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26657.894736842107], "unit": "score", "name": "RegExp", "value": 34.173178677196454}, {"lowerIsBetter": false, "replicates": [589.2751915144372], "unit": "score", "name": "Splay", "value": 138.29022699999996}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7", "value": 19750.362624394485}]} 12:38:31 INFO - RETURN: dromaeo_css: 6298.95 12:38:31 INFO - RETURN: kraken: 1508.40 12:38:31 INFO - RETURN: v8_7: 19750.36 12:38:31 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19750.36"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1508.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6298.95"}}} 12:38:31 INFO - Return code: 0 12:38:31 INFO - # TBPL SUCCESS # 12:38:31 INFO - Running post-action listener: _resource_record_post_action 12:38:31 INFO - Running post-run listener: _resource_record_post_run 12:38:32 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 502042624; Read time: 216; Write time: 323404 12:38:32 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 125771776; Read time: 0; Write time: 71020 12:38:32 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 0; Write bytes: 302084096; Read time: 0; Write time: 192704 12:38:32 INFO - Running post-run listener: _upload_blobber_files 12:38:32 INFO - Blob upload gear active. 12:38:32 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:38:32 INFO - Copying logs to upload dir... 12:38:32 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.435906 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-23 12:38:32.736857) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:38:32.740529) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 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.009946 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:38:32.793079) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:38:32.793500) ========= 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=61fa6ed41387771909ec0f71000001b3-1448309849.31876-1064515927 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004618 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:38:32.843436) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:38:32.843868) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:38:32.844238) ========= ========= Total master_lag: 0.21 =========