builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-057 starttime: 1448309762.49 results: success (0) buildid: 20151121014332 builduid: 366d0f62097c4c84bad0a3f63b5705d4 revision: 489332006384610e3322739f66729448da0e98d9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.490106) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.491133) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.491684) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006154 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.515979) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.516464) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.531959) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.532397) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004810 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.582254) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.582550) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.582916) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.583201) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 12:16:03-- 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% 226M=0s 2015-11-23 12:16:03 (226 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.202407 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.797974) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.798342) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.020219 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:02.848078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:16:02.848523) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 12:16:03,674 truncating revision to first 12 chars 2015-11-23 12:16:03,674 Setting DEBUG logging. 2015-11-23 12:16:03,674 attempt 1/10 2015-11-23 12:16:03,674 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/489332006384?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 12:16:04,610 unpacking tar archive at: fx-team-489332006384/testing/mozharness/ program finished with exit code 0 elapsedTime=1.263330 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 12:16:04.125006) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.125415) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.136839) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.137235) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 12:16:04.137838) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-23 12:16:04.138283) ========= /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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 12:16:05 INFO - MultiFileLogger online at 20151123 12:16:05 in /builds/slave/test 12:16:05 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO 12:16:05 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:16:05 INFO - {'append_to_log': False, 12:16:05 INFO - 'base_work_dir': '/builds/slave/test', 12:16:05 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 12:16:05 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:16:05 INFO - 'branch': 'Fx-Team-Non-PGO', 12:16:05 INFO - 'buildbot_json_path': 'buildprops.json', 12:16:05 INFO - 'config_files': ('talos/linux_config.py',), 12:16:05 INFO - 'default_actions': ('clobber', 12:16:05 INFO - 'read-buildbot-config', 12:16:05 INFO - 'download-and-extract', 12:16:05 INFO - 'populate-webroot', 12:16:05 INFO - 'create-virtualenv', 12:16:05 INFO - 'install', 12:16:05 INFO - 'run-tests'), 12:16:05 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:16:05 INFO - 'download_minidump_stackwalk': True, 12:16:05 INFO - 'download_symbols': 'ondemand', 12:16:05 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:16:05 INFO - 'tooltool.py': '/tools/tooltool.py', 12:16:05 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:16:05 INFO - '/tools/misc-python/virtualenv.py')}, 12:16:05 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:16:05 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:16:05 INFO - 'installer_path': 'installer.exe', 12:16:05 INFO - 'log_level': 'info', 12:16:05 INFO - 'log_name': 'talos', 12:16:05 INFO - 'log_to_console': True, 12:16:05 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 12:16:05 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 12:16:05 INFO - 'opt_config_files': (), 12:16:05 INFO - 'pip_index': False, 12:16:05 INFO - 'sps_profile': False, 12:16:05 INFO - 'sps_profile_interval': 0, 12:16:05 INFO - 'suite': 'dromaeojs', 12:16:05 INFO - 'system_bits': '64', 12:16:05 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:16:05 INFO - 'title': 'talos-linux64-ix-057', 12:16:05 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:16:05 INFO - 'use_talos_json': True, 12:16:05 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:16:05 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:16:05 INFO - 'work_dir': 'build'} 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running clobber step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: clobber 12:16:05 INFO - rmtree: /builds/slave/test/build 12:16:05 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running read-buildbot-config step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: read_buildbot_config 12:16:05 INFO - Using buildbot properties: 12:16:05 INFO - { 12:16:05 INFO - "properties": { 12:16:05 INFO - "buildnumber": 2108, 12:16:05 INFO - "product": "firefox", 12:16:05 INFO - "script_repo_revision": "production", 12:16:05 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 12:16:05 INFO - "repository": "", 12:16:05 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 12:16:05 INFO - "buildid": "20151121014332", 12:16:05 INFO - "slavename": "talos-linux64-ix-057", 12:16:05 INFO - "pgo_build": "False", 12:16:05 INFO - "basedir": "/builds/slave/test", 12:16:05 INFO - "project": "", 12:16:05 INFO - "platform": "ubuntu64_hw", 12:16:05 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 12:16:05 INFO - "slavebuilddir": "test", 12:16:05 INFO - "scheduler": "tests-fx-team-linux64-talos", 12:16:05 INFO - "branch": "fx-team", 12:16:05 INFO - "repo_path": "integration/fx-team", 12:16:05 INFO - "stage_platform": "linux64", 12:16:05 INFO - "builduid": "366d0f62097c4c84bad0a3f63b5705d4", 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - }, 12:16:05 INFO - "sourcestamp": { 12:16:05 INFO - "repository": "", 12:16:05 INFO - "hasPatch": false, 12:16:05 INFO - "project": "", 12:16:05 INFO - "branch": "fx-team-linux64-talos", 12:16:05 INFO - "changes": [ 12:16:05 INFO - { 12:16:05 INFO - "category": null, 12:16:05 INFO - "files": [ 12:16:05 INFO - { 12:16:05 INFO - "url": null, 12:16:05 INFO - "name": "https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "repository": "", 12:16:05 INFO - "rev": "489332006384610e3322739f66729448da0e98d9", 12:16:05 INFO - "who": "dgottwald@mozilla.com", 12:16:05 INFO - "when": 1448100613, 12:16:05 INFO - "number": 6692170, 12:16:05 INFO - "comments": "Bug 644529 - Remove gap between bookmarks toolbar menu buttons and their popups. r=gijs", 12:16:05 INFO - "project": "", 12:16:05 INFO - "at": "Sat 21 Nov 2015 02:10:13", 12:16:05 INFO - "branch": "fx-team-linux64-talos", 12:16:05 INFO - "revlink": "", 12:16:05 INFO - "properties": [ 12:16:05 INFO - [ 12:16:05 INFO - "buildid", 12:16:05 INFO - "20151121014332", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "builduid", 12:16:05 INFO - "366d0f62097c4c84bad0a3f63b5705d4", 12:16:05 INFO - "Change" 12:16:05 INFO - ], 12:16:05 INFO - [ 12:16:05 INFO - "pgo_build", 12:16:05 INFO - "False", 12:16:05 INFO - "Change" 12:16:05 INFO - ] 12:16:05 INFO - ], 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - } 12:16:05 INFO - ], 12:16:05 INFO - "revision": "489332006384610e3322739f66729448da0e98d9" 12:16:05 INFO - } 12:16:05 INFO - } 12:16:05 INFO - Found installer url https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 12:16:05 INFO - Running post-action listener: _resource_record_post_action 12:16:05 INFO - ##### 12:16:05 INFO - ##### Running download-and-extract step. 12:16:05 INFO - ##### 12:16:05 INFO - Running pre-action listener: _resource_record_pre_action 12:16:05 INFO - Running main action method: download_and_extract 12:16:05 INFO - mkdir: /builds/slave/test/build/tests 12:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:05 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:16:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json 12:16:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:16:06 INFO - Downloaded 1302 bytes. 12:16:06 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:16:06 INFO - Using the following test package requirements: 12:16:06 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 12:16:06 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'jsshell-linux-x86_64.zip'], 12:16:06 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 12:16:06 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 12:16:06 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 12:16:06 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 12:16:06 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 12:16:06 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 12:16:06 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 12:16:06 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 12:16:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:06 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:06 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:06 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:06 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:07 INFO - Downloaded 21339409 bytes. 12:16:07 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:16:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:07 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:16:08 INFO - Return code: 0 12:16:08 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 12:16:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:08 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 12:16:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 12:16:09 INFO - Downloaded 21339409 bytes. 12:16:09 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 12:16:09 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 12:16:09 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 12:16:10 INFO - Return code: 0 12:16:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:10 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 12:16:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 12:16:11 INFO - Downloaded 11130997 bytes. 12:16:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] in /builds/slave/test/build/tests 12:16:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 12:16:11 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] with output_timeout 1760 12:16:11 INFO - Return code: 0 12:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:11 INFO - https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 12:16:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 12:16:13 INFO - Downloaded 55909927 bytes. 12:16:13 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:13 INFO - mkdir: /builds/slave/test/properties 12:16:13 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:16:13 INFO - Writing to file /builds/slave/test/properties/build_url 12:16:13 INFO - Contents: 12:16:13 INFO - build_url:https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 12:16:13 INFO - Running post-action listener: _resource_record_post_action 12:16:13 INFO - Running post-action listener: set_extra_try_arguments 12:16:13 INFO - ##### 12:16:13 INFO - ##### Running populate-webroot step. 12:16:13 INFO - ##### 12:16:13 INFO - Running pre-action listener: _resource_record_pre_action 12:16:13 INFO - Running main action method: populate_webroot 12:16:13 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:16:13 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:16:13 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:16:13 INFO - '../fennec_ids.txt'], 12:16:13 INFO - 'tests': ['tcheck2']}, 12:16:13 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:16:13 INFO - '--tppagecycles', 12:16:13 INFO - '7'], 12:16:13 INFO - 'tests': ['tsvgm']}}, 12:16:13 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:16:13 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:16:13 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:13 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:16:13 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:13 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:16:13 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'tests': ['damp', 'tps']}, 12:16:13 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['damp', 'tps']}, 12:16:13 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:16:13 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:16:13 INFO - 'other': {'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'other_l64': {'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'other_nol64': {'tests': ['a11yr', 12:16:13 INFO - 'ts_paint', 12:16:13 INFO - 'tpaint', 12:16:13 INFO - 'sessionrestore', 12:16:13 INFO - 'sessionrestore_no_auto_restore']}, 12:16:13 INFO - 'svgr': {'tests': ['tsvgx', 12:16:13 INFO - 'tsvgr_opacity', 12:16:13 INFO - 'tart', 12:16:13 INFO - 'tscrollx', 12:16:13 INFO - 'cart']}, 12:16:13 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['tsvgx', 12:16:13 INFO - 'tsvgr_opacity', 12:16:13 INFO - 'tart', 12:16:13 INFO - 'tscrollx', 12:16:13 INFO - 'cart']}, 12:16:13 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'tests': ['tp5o']}, 12:16:13 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'talos_options': ['--e10s'], 12:16:13 INFO - 'tests': ['tp5o']}, 12:16:13 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'talos_options': ['--xperf_path', 12:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:13 INFO - 'tests': ['tp5n']}, 12:16:13 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:16:13 INFO - 'talos_options': ['--e10s', 12:16:13 INFO - '--xperf_path', 12:16:13 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:16:13 INFO - 'tests': ['tp5n']}}, 12:16:13 INFO - 'talos.zip': {'path': '', 12:16:13 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:16:13 INFO - Running post-action listener: _resource_record_post_action 12:16:13 INFO - ##### 12:16:13 INFO - ##### Running create-virtualenv step. 12:16:13 INFO - ##### 12:16:13 INFO - Running pre-action listener: _resource_record_pre_action 12:16:13 INFO - Running main action method: create_virtualenv 12:16:13 INFO - Creating virtualenv /builds/slave/test/build/venv 12:16:13 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 12:16:13 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:16:13 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:16:13 INFO - Using real prefix '/usr' 12:16:13 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:16:13 INFO - Installing distribute.............................................................................................................................................................................................done. 12:16:15 INFO - Installing pip.................done. 12:16:15 INFO - Return code: 0 12:16:15 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 12:16:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 12:16:15 INFO - Using env: {'DISPLAY': ':0', 12:16:15 INFO - 'HOME': '/home/cltbld', 12:16:15 INFO - 'LANG': 'en_US.UTF-8', 12:16:15 INFO - 'LANGUAGE': 'en_US:en', 12:16:15 INFO - 'LOGNAME': 'cltbld', 12:16:15 INFO - 'MAIL': '/var/mail/cltbld', 12:16:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:15 INFO - 'MOZ_NO_REMOTE': '1', 12:16:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:15 INFO - 'NO_EM_RESTART': '1', 12:16:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:15 INFO - 'PWD': '/builds/slave/test', 12:16:15 INFO - 'SHELL': '/bin/bash', 12:16:15 INFO - 'SHLVL': '1', 12:16:15 INFO - 'TERM': 'linux', 12:16:15 INFO - 'TMOUT': '86400', 12:16:15 INFO - 'USER': 'cltbld', 12:16:15 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:15 INFO - '_': '/tools/buildbot/bin/python'} 12:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:16 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 12:16:16 INFO - Cleaning up... 12:16:16 INFO - Return code: 0 12:16:16 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:16 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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 12:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 12:16:16 INFO - Using env: {'DISPLAY': ':0', 12:16:16 INFO - 'HOME': '/home/cltbld', 12:16:16 INFO - 'LANG': 'en_US.UTF-8', 12:16:16 INFO - 'LANGUAGE': 'en_US:en', 12:16:16 INFO - 'LOGNAME': 'cltbld', 12:16:16 INFO - 'MAIL': '/var/mail/cltbld', 12:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:16 INFO - 'MOZ_NO_REMOTE': '1', 12:16:16 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:16 INFO - 'NO_EM_RESTART': '1', 12:16:16 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:16 INFO - 'PWD': '/builds/slave/test', 12:16:16 INFO - 'SHELL': '/bin/bash', 12:16:16 INFO - 'SHLVL': '1', 12:16:16 INFO - 'TERM': 'linux', 12:16:16 INFO - 'TMOUT': '86400', 12:16:16 INFO - 'USER': 'cltbld', 12:16:16 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:16 INFO - '_': '/tools/buildbot/bin/python'} 12:16:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:16 INFO - Downloading/unpacking psutil>=0.7.1 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:16:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:16:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:18 INFO - Installing collected packages: psutil 12:16:18 INFO - Running setup.py install for psutil 12:16:18 INFO - building 'psutil._psutil_linux' extension 12:16:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 12:16:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 12:16:18 INFO - building 'psutil._psutil_posix' extension 12:16:18 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 12:16:18 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 12:16:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:16:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:16:18 INFO - Successfully installed psutil 12:16:18 INFO - Cleaning up... 12:16:18 INFO - Return code: 0 12:16:18 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:18 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 12:16:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 12:16:18 INFO - Using env: {'DISPLAY': ':0', 12:16:18 INFO - 'HOME': '/home/cltbld', 12:16:18 INFO - 'LANG': 'en_US.UTF-8', 12:16:18 INFO - 'LANGUAGE': 'en_US:en', 12:16:18 INFO - 'LOGNAME': 'cltbld', 12:16:18 INFO - 'MAIL': '/var/mail/cltbld', 12:16:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:18 INFO - 'MOZ_NO_REMOTE': '1', 12:16:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:18 INFO - 'NO_EM_RESTART': '1', 12:16:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:18 INFO - 'PWD': '/builds/slave/test', 12:16:18 INFO - 'SHELL': '/bin/bash', 12:16:18 INFO - 'SHLVL': '1', 12:16:18 INFO - 'TERM': 'linux', 12:16:18 INFO - 'TMOUT': '86400', 12:16:18 INFO - 'USER': 'cltbld', 12:16:18 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:18 INFO - '_': '/tools/buildbot/bin/python'} 12:16:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:18 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:18 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:18 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:20 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:16:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:16:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:16:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:16:20 INFO - Installing collected packages: mozsystemmonitor 12:16:20 INFO - Running setup.py install for mozsystemmonitor 12:16:20 INFO - Successfully installed mozsystemmonitor 12:16:20 INFO - Cleaning up... 12:16:20 INFO - Return code: 0 12:16:20 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:20 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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 12:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 12:16:20 INFO - Using env: {'DISPLAY': ':0', 12:16:20 INFO - 'HOME': '/home/cltbld', 12:16:20 INFO - 'LANG': 'en_US.UTF-8', 12:16:20 INFO - 'LANGUAGE': 'en_US:en', 12:16:20 INFO - 'LOGNAME': 'cltbld', 12:16:20 INFO - 'MAIL': '/var/mail/cltbld', 12:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:20 INFO - 'MOZ_NO_REMOTE': '1', 12:16:20 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:20 INFO - 'NO_EM_RESTART': '1', 12:16:20 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:20 INFO - 'PWD': '/builds/slave/test', 12:16:20 INFO - 'SHELL': '/bin/bash', 12:16:20 INFO - 'SHLVL': '1', 12:16:20 INFO - 'TERM': 'linux', 12:16:20 INFO - 'TMOUT': '86400', 12:16:20 INFO - 'USER': 'cltbld', 12:16:20 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:20 INFO - '_': '/tools/buildbot/bin/python'} 12:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:20 INFO - Downloading/unpacking blobuploader==1.2.4 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:22 INFO - Downloading blobuploader-1.2.4.tar.gz 12:16:22 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:16:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:16:22 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:22 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:22 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:22 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:22 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:16:23 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:23 INFO - Downloading docopt-0.6.1.tar.gz 12:16:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:16:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:16:23 INFO - Installing collected packages: blobuploader, requests, docopt 12:16:23 INFO - Running setup.py install for blobuploader 12:16:23 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:16:23 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:16:23 INFO - Running setup.py install for requests 12:16:23 INFO - Running setup.py install for docopt 12:16:23 INFO - Successfully installed blobuploader requests docopt 12:16:23 INFO - Cleaning up... 12:16:24 INFO - Return code: 0 12:16:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:24 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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:24 INFO - Using env: {'DISPLAY': ':0', 12:16:24 INFO - 'HOME': '/home/cltbld', 12:16:24 INFO - 'LANG': 'en_US.UTF-8', 12:16:24 INFO - 'LANGUAGE': 'en_US:en', 12:16:24 INFO - 'LOGNAME': 'cltbld', 12:16:24 INFO - 'MAIL': '/var/mail/cltbld', 12:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:24 INFO - 'MOZ_NO_REMOTE': '1', 12:16:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:24 INFO - 'NO_EM_RESTART': '1', 12:16:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:24 INFO - 'PWD': '/builds/slave/test', 12:16:24 INFO - 'SHELL': '/bin/bash', 12:16:24 INFO - 'SHLVL': '1', 12:16:24 INFO - 'TERM': 'linux', 12:16:24 INFO - 'TMOUT': '86400', 12:16:24 INFO - 'USER': 'cltbld', 12:16:24 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:24 INFO - '_': '/tools/buildbot/bin/python'} 12:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:24 INFO - Running setup.py (path:/tmp/pip-hVcunv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:24 INFO - Running setup.py (path:/tmp/pip-QZ4iW0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:24 INFO - Running setup.py (path:/tmp/pip-xde60J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:24 INFO - Running setup.py (path:/tmp/pip-BnkNbL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:24 INFO - Running setup.py (path:/tmp/pip-OkKVpK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:24 INFO - Running setup.py (path:/tmp/pip-i61J8u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:24 INFO - Running setup.py (path:/tmp/pip-HxC_Tb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:24 INFO - Running setup.py (path:/tmp/pip-9Jo49O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:24 INFO - Running setup.py (path:/tmp/pip-QDeDtY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:24 INFO - Running setup.py (path:/tmp/pip-MlCyft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:24 INFO - Running setup.py (path:/tmp/pip-m7Wrcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:25 INFO - Running setup.py (path:/tmp/pip-cTpbin-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:25 INFO - Running setup.py (path:/tmp/pip-IkpbVB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:25 INFO - Running setup.py (path:/tmp/pip-No2_9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:25 INFO - Running setup.py (path:/tmp/pip-_TVNmL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:25 INFO - Running setup.py (path:/tmp/pip-xXG3RB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:25 INFO - Running setup.py (path:/tmp/pip-638NiL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:25 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:16:25 INFO - Running setup.py install for manifestparser 12:16:25 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for mozcrash 12:16:25 INFO - Running setup.py install for mozdebug 12:16:25 INFO - Running setup.py install for mozdevice 12:16:25 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:16:25 INFO - Running setup.py install for mozfile 12:16:25 INFO - Running setup.py install for mozhttpd 12:16:26 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozinfo 12:16:26 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozInstall 12:16:26 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozleak 12:16:26 INFO - Running setup.py install for mozlog 12:16:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for moznetwork 12:16:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozprocess 12:16:26 INFO - Running setup.py install for mozprofile 12:16:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozrunner 12:16:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:16:26 INFO - Running setup.py install for mozscreenshot 12:16:26 INFO - Running setup.py install for moztest 12:16:27 INFO - Running setup.py install for mozversion 12:16:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:16:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:16:27 INFO - Cleaning up... 12:16:27 INFO - Return code: 0 12:16:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:27 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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 12:16:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:27 INFO - Using env: {'DISPLAY': ':0', 12:16:27 INFO - 'HOME': '/home/cltbld', 12:16:27 INFO - 'LANG': 'en_US.UTF-8', 12:16:27 INFO - 'LANGUAGE': 'en_US:en', 12:16:27 INFO - 'LOGNAME': 'cltbld', 12:16:27 INFO - 'MAIL': '/var/mail/cltbld', 12:16:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:27 INFO - 'MOZ_NO_REMOTE': '1', 12:16:27 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:27 INFO - 'NO_EM_RESTART': '1', 12:16:27 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:27 INFO - 'PWD': '/builds/slave/test', 12:16:27 INFO - 'SHELL': '/bin/bash', 12:16:27 INFO - 'SHLVL': '1', 12:16:27 INFO - 'TERM': 'linux', 12:16:27 INFO - 'TMOUT': '86400', 12:16:27 INFO - 'USER': 'cltbld', 12:16:27 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:27 INFO - '_': '/tools/buildbot/bin/python'} 12:16:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:16:27 INFO - Running setup.py (path:/tmp/pip-YpwXGE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:16:27 INFO - Running setup.py (path:/tmp/pip-Gfl8RO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:16:27 INFO - Running setup.py (path:/tmp/pip-wGQjIo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:16:27 INFO - Running setup.py (path:/tmp/pip-DNO0Gr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:16:27 INFO - Running setup.py (path:/tmp/pip-egUIsf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:16:27 INFO - Running setup.py (path:/tmp/pip-myC2LJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:16:27 INFO - Running setup.py (path:/tmp/pip-JkPz6j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:16:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 12:16:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:16:27 INFO - Running setup.py (path:/tmp/pip-Nd46km-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:16:28 INFO - Running setup.py (path:/tmp/pip-qT8BXN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:16:28 INFO - Running setup.py (path:/tmp/pip-j2irrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:16:28 INFO - Running setup.py (path:/tmp/pip-qZGrco-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:16:28 INFO - Running setup.py (path:/tmp/pip-gTvXso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:16:28 INFO - Running setup.py (path:/tmp/pip-a3RMP1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:16:28 INFO - Running setup.py (path:/tmp/pip-fOg6lQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:28 INFO - Running setup.py (path:/tmp/pip-pAstHZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:16:28 INFO - Running setup.py (path:/tmp/pip-iFFv4s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 12:16:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:16:28 INFO - Running setup.py (path:/tmp/pip-q4w7ZK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:28 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 12:16:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:16:30 INFO - Downloading blessings-1.5.1.tar.gz 12:16:30 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 12:16:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:16:30 INFO - Installing collected packages: blessings 12:16:30 INFO - Running setup.py install for blessings 12:16:30 INFO - Successfully installed blessings 12:16:30 INFO - Cleaning up... 12:16:30 INFO - Return code: 0 12:16:30 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:16:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:30 INFO - Reading from file tmpfile_stdout 12:16:30 INFO - Current package versions: 12:16:30 INFO - argparse == 1.2.1 12:16:30 INFO - blessings == 1.5.1 12:16:30 INFO - blobuploader == 1.2.4 12:16:30 INFO - docopt == 0.6.1 12:16:30 INFO - manifestparser == 1.1 12:16:30 INFO - mozInstall == 1.12 12:16:30 INFO - mozcrash == 0.16 12:16:30 INFO - mozdebug == 0.1 12:16:30 INFO - mozdevice == 0.47 12:16:30 INFO - mozfile == 1.2 12:16:30 INFO - mozhttpd == 0.7 12:16:30 INFO - mozinfo == 0.9 12:16:30 INFO - mozleak == 0.1 12:16:30 INFO - mozlog == 3.0 12:16:30 INFO - moznetwork == 0.27 12:16:30 INFO - mozprocess == 0.22 12:16:30 INFO - mozprofile == 0.27 12:16:30 INFO - mozrunner == 6.11 12:16:30 INFO - mozscreenshot == 0.1 12:16:30 INFO - mozsystemmonitor == 0.0 12:16:30 INFO - moztest == 0.7 12:16:30 INFO - mozversion == 1.4 12:16:30 INFO - psutil == 3.1.1 12:16:30 INFO - requests == 1.2.3 12:16:30 INFO - wsgiref == 0.1.2 12:16:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:16:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:16:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:16:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:16:30 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 0x7f2c826bec70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x28616c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2912900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, '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': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 12:16:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 12:16:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 12:16:30 INFO - Using env: {'DISPLAY': ':0', 12:16:30 INFO - 'HOME': '/home/cltbld', 12:16:30 INFO - 'LANG': 'en_US.UTF-8', 12:16:30 INFO - 'LANGUAGE': 'en_US:en', 12:16:30 INFO - 'LOGNAME': 'cltbld', 12:16:30 INFO - 'MAIL': '/var/mail/cltbld', 12:16:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:30 INFO - 'MOZ_NO_REMOTE': '1', 12:16:30 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:30 INFO - 'NO_EM_RESTART': '1', 12:16:30 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:30 INFO - 'PWD': '/builds/slave/test', 12:16:30 INFO - 'SHELL': '/bin/bash', 12:16:30 INFO - 'SHLVL': '1', 12:16:30 INFO - 'TERM': 'linux', 12:16:30 INFO - 'TMOUT': '86400', 12:16:30 INFO - 'USER': 'cltbld', 12:16:30 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:30 INFO - '_': '/tools/buildbot/bin/python'} 12:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 12:16:31 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 12:16:31 INFO - Cleaning up... 12:16:31 INFO - Return code: 0 12:16:31 INFO - Running post-action listener: _resource_record_post_action 12:16:31 INFO - Running post-action listener: _start_resource_monitoring 12:16:31 INFO - Starting resource monitoring. 12:16:31 INFO - ##### 12:16:31 INFO - ##### Running install step. 12:16:31 INFO - ##### 12:16:31 INFO - Running pre-action listener: _resource_record_pre_action 12:16:31 INFO - Running main action method: install 12:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:16:31 INFO - Reading from file tmpfile_stdout 12:16:31 INFO - Detecting whether we're running mozinstall >=1.0... 12:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:16:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:16:31 INFO - Reading from file tmpfile_stdout 12:16:31 INFO - Output received: 12:16:31 INFO - Usage: mozinstall [options] installer 12:16:31 INFO - Options: 12:16:31 INFO - -h, --help show this help message and exit 12:16:31 INFO - -d DEST, --destination=DEST 12:16:31 INFO - Directory to install application into. [default: 12:16:31 INFO - "/builds/slave/test"] 12:16:31 INFO - --app=APP Application being installed. [default: firefox] 12:16:31 INFO - mkdir: /builds/slave/test/build/application 12:16:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 12:16:31 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:16:45 INFO - Reading from file tmpfile_stdout 12:16:45 INFO - Output received: 12:16:45 INFO - /builds/slave/test/build/application/firefox/firefox 12:16:45 INFO - Running post-action listener: _resource_record_post_action 12:16:45 INFO - ##### 12:16:45 INFO - ##### Running run-tests step. 12:16:45 INFO - ##### 12:16:45 INFO - Running pre-action listener: _resource_record_pre_action 12:16:45 INFO - Running main action method: run_tests 12:16:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:16:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:16:45 INFO - Python 2.7.3 12:16:45 INFO - Return code: 0 12:16:45 INFO - grabbing minidump binary from tooltool 12:16: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:16:45 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 0x2958b70>, '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 0x29a9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x29aa250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:16:45 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:16:45 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:16:45 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:16:45 INFO - Return code: 0 12:16:45 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 12:16:45 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:16:45 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:16:45 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 12:16:45 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:16:45 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-057', '--webServer', 'localhost'] in /builds/slave/test/build 12:16:45 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-057 --webServer localhost 12:16:45 INFO - Using env: {'DISPLAY': ':0', 12:16:45 INFO - 'HOME': '/home/cltbld', 12:16:45 INFO - 'LANG': 'en_US.UTF-8', 12:16:45 INFO - 'LANGUAGE': 'en_US:en', 12:16:45 INFO - 'LOGNAME': 'cltbld', 12:16:45 INFO - 'MAIL': '/var/mail/cltbld', 12:16:45 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:16:45 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 12:16:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:16:45 INFO - 'MOZ_NO_REMOTE': '1', 12:16:45 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:16:45 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 12:16:45 INFO - 'NO_EM_RESTART': '1', 12:16:45 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 12:16:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:16:45 INFO - 'PWD': '/builds/slave/test', 12:16:45 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:16:45 INFO - 'SHELL': '/bin/bash', 12:16:45 INFO - 'SHLVL': '1', 12:16:45 INFO - 'TERM': 'linux', 12:16:45 INFO - 'TMOUT': '86400', 12:16:45 INFO - 'USER': 'cltbld', 12:16:45 INFO - 'XDG_SESSION_COOKIE': '6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249', 12:16:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:16:45 INFO - '_': '/tools/buildbot/bin/python'} 12:16:45 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-057', '--webServer', 'localhost'] with output_timeout 3600 12:16:45 INFO - mozversion INFO | application_buildid: 20151121014332 12:16:45 INFO - mozversion INFO | application_changeset: 489332006384610e3322739f66729448da0e98d9 12:16:45 INFO - mozversion INFO | application_display_name: Nightly 12:16:45 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:16:45 INFO - mozversion INFO | application_name: Firefox 12:16:45 INFO - mozversion INFO | application_remotingname: firefox 12:16:45 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:16:45 INFO - mozversion INFO | application_vendor: Mozilla 12:16:45 INFO - mozversion INFO | application_version: 45.0a1 12:16:45 INFO - mozversion INFO | platform_buildid: 20151121014332 12:16:45 INFO - mozversion INFO | platform_changeset: 489332006384610e3322739f66729448da0e98d9 12:16:45 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:16:45 INFO - mozversion INFO | platform_version: 45.0a1 12:16:45 INFO - 2015-11-23 12:16:45,724 DEBUG : using testdate: 1448309805 12:16:45 INFO - 2015-11-23 12:16:45,724 DEBUG : actual date: 1448309805 12:16:45 INFO - 2015-11-23 12:16:45,732 INFO : starting webserver on 'localhost:57435' 12:16:45 INFO - 2015-11-23 12:16:45,733 INFO : Starting test suite talos-linux64-ix-057 12:16:45 INFO - 2015-11-23 12:16:45,733 INFO : Starting test dromaeo_css 12:16:45 INFO - 2015-11-23 12:16:45,733 DEBUG : operating with platform_type : linux_ 12:16:45 INFO - 2015-11-23 12:16:45,734 INFO : Initialising browser for dromaeo_css test... 12:16:45 INFO - 2015-11-23 12:16:45,749 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4G1R_j/profile http://localhost:57435/getInfo.html 12:16:50 INFO - 2015-11-23 12:16:50,580 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:16:50 INFO - 2015-11-23 12:16:50,580 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:16:50 INFO - 2015-11-23 12:16:50,580 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:16:50 INFO - 2015-11-23 12:16:50,580 DEBUG : BROWSER_OUTPUT: __metrics 12:16:50 INFO - 2015-11-23 12:16:50,705 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:16:51 INFO - 2015-11-23 12:16:51,917 INFO : Browser initialized. 12:16:51 INFO - 2015-11-23 12:16:51,918 INFO : Running cycle 1/1 for dromaeo_css test... 12:16:51 INFO - 2015-11-23 12:16:51,918 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4G1R_j/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:17:03 INFO - 2015-11-23 12:17:03,818 DEBUG : BROWSER_OUTPUT: RSS: Main: 142065664 12:17:03 INFO - 2015-11-23 12:17:03,819 DEBUG : BROWSER_OUTPUT: 12:17:55 INFO - 2015-11-23 12:17:55,333 DEBUG : BROWSER_OUTPUT: 1448309875331 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 12:20:07 INFO - 2015-11-23 12:20:07,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57435/tests/dromaeo/cssquery-ext.html) 12:20:08 INFO - 2015-11-23 12:20:08,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 239693824 12:20:08 INFO - 2015-11-23 12:20:08,663 DEBUG : BROWSER_OUTPUT: 12:23:11 INFO - 2015-11-23 12:23:11,158 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-ext.html (next: http://localhost:57435/tests/dromaeo/cssquery-jquery.html) 12:23:11 INFO - 2015-11-23 12:23:11,732 DEBUG : BROWSER_OUTPUT: RSS: Main: 217976832 12:23:11 INFO - 2015-11-23 12:23:11,732 DEBUG : BROWSER_OUTPUT: 12:26:13 INFO - 2015-11-23 12:26:13,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57435/tests/dromaeo/cssquery-mootools.html) 12:26:14 INFO - 2015-11-23 12:26:14,251 DEBUG : BROWSER_OUTPUT: RSS: Main: 210358272 12:26:14 INFO - 2015-11-23 12:26:14,252 DEBUG : BROWSER_OUTPUT: 12:29:16 INFO - 2015-11-23 12:29:16,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57435/tests/dromaeo/cssquery-prototype.html) 12:29:16 INFO - 2015-11-23 12:29:16,781 DEBUG : BROWSER_OUTPUT: RSS: Main: 202457088 12:29:16 INFO - 2015-11-23 12:29:16,781 DEBUG : BROWSER_OUTPUT: 12:32:19 INFO - 2015-11-23 12:32:19,493 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57435/tests/dromaeo/cssquery-yui.html) 12:32:20 INFO - 2015-11-23 12:32:20,081 DEBUG : BROWSER_OUTPUT: RSS: Main: 207245312 12:32:20 INFO - 2015-11-23 12:32:20,082 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,609 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/dromaeo/cssquery-yui.html (next: http://localhost:57435/tests/dromaeo/cssquery-dojo.html) 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: RSS: Main: 250314752 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2628.934276643084;2719.9184024479273;2724;2748.326659968307;2750.8487033213164;4467;4612.723236605798;4672.135654903841;4692.343071969923;4708.552687494687;4626.329182268569;4626.421697287839;4688.859334219979;4692.624590032798;4693.342931989524;4324.524302326741;4366.585174408426;4390.253656878331;4468.798904049309;4516.954830451687;4195.979020104895;4418.977905110486;4453.953320969569;4490.640748740093;4543.6819422640265;4243.978780106079;4303.35449682547;4313.137372525476;4325.351197320396;4330.372096046056;4328.523862375137;4344.913101737948;4349.521552629209;4380.34294855771;4402.955970440286;4138.461999940018;4223.97888010558;4304.246756817544;4326.718763280377;4369.759663218521;4528.728276303399;4547.727136371828;4662.160811054009;4685.273782563708;4726.1020406122725;5031.144705400091;5033.644150709841;5059.6458247922665;5060.139776238048;5093.1850903855575;4827.686200396963;4978.527039931237;5084.694918304914;5097.8215762448135;5100.872478188038;4583.289590113538;4617.122746678154;4622.052479241747;4665.603423708955;4676.649251306166;5269.130593452114;5297.046531624344;5303.178007408857;5306.8407947761625;5307.124324486494;5074.771635276422;5086.77109530072;5093.694378337312;5095.770690318945;5147.6911385317;4837.879053023632;4944.629152813553;4947.529984651453;4979.701217926936;5176.068307704574;4860.416749989953;4872.610191184696;4891.3396691446915;4994.475580064113;5028;4963.057019166346;5015.197568389113;5038.395392552844;5072.82245121419;5116.820911268088;4044.4742183515955;4141.109661422808;4238.449001629769;4277.700560960765;4323.308270676676;3638.508801311789;3648.835802388899;3701.204241088179;3728.5898551159353;3734.2718169956597;4391.604755572014;4395.912081758347;4406.228909940747;4414.117176564636;4437.356583295468;4838.975805120952;4942.258661200777;5110.821121260738;5112.769925353368;5161.148410512224;4297.914041719148;4342.5874541918465;4354.020345422318;4386.8025938832825;4405.31717583775;4497.033137875307;4535.773211339486;4544.704594201433;4546.204414227497;4587.816487340469;4851.539103785135;4852.296417019513;4854.271859221145;4854.538818812207;4893.510648935149;4783.904321913612;4882.60939124862;4883.95116048835;4979.452260251442;5098.260752190838;4803.903921921472;4807.61539076866;4809.759512024315;4810.735409552508;4863.197572400514;4975.850724478271;4979.651424400257;4983.152864013199;4994.9750251248515;5026.59787217029;4826.348442960156;4933.6299777516115;4939.851804445872;4986.750662466789;5022.773975171199;4834.178189707828;4844.709317440965;4850.272459131017;4913.06651736169;4949.059678661043;4849.781759820746;4887.242477416006;4891.241857512091;4942.085714142895;4943.505649435172;4565.703229290086;4638.628909687284;4677.204875171161;4761;4857.902841943071;4911.066897289504;4927.236278376858;4931.778069986787;4938.555530002317;4945.109880221595;4774.236122220428;4812.927806082982;4813.278008298643;4823;4868.586170175575 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: |1;ext.html;561;571.5941681406201;574.2448679985819;579.7420148034126;581.0963951056108;28792.56811147832;29384.559231611544;37073.81463092688;37571.4364284536;37612.62387376125;41159.794201028955;41674;41730.58269417313;41762.58237417625;41781.58218417822;6917.377436030756;7016.859662806741;7818.8827167592535;7908.762737117896;7989.960050199741;10051;10216.642417515388;10256;10334.121599664037;10338.172946164326;10034.247431442634;10133.290669653128;10148.49257537124;10164.745881352952;10164.847527287096;7253.347198752138;7370.815729606749;10007.099361057504;10066.647667331681;10388.220883433773;9672.56473458696;9786.90213097867;9792.804143917154;9792.90207097927;9794.16749576287;37249.44125838114;37608.49566017356;37745.81127094347;37793.43309850354;37854.43218351727;2841.9289517762013;2969.4305773782244;2969.5248760198265;3028.242939265184;3508.8421021054114;28261.434771304663;28361.054565314655;28661;28771.712282877113;29013;3329.167708072982;3340.8997730068136;3384.830758462067;3387.0685561470546;3476.617572067071;239613;239826;240221;240389;240517;50974;52176.21735673968;55203.44796551983;55880.44119558833;55881;63629.68185159137;63831.361686382545;63863.68068159722;64090.59094090647;64284;13578.93210533941;13775.311234438239;13789.379477923518;13798.724025519434;13798.862011379757;10171.440570768531;10203.132733717717;10239.259325914612;10245.231607629308;10253.84619230712;18496;18536.258549658134;18589.34937277189;18613.627727445648;18651.626967460576;7065.6113913735235;7290.927090729131;7377.151627562899;7377.594232317274;7386.704531818775;843.5529169540154;891.5987805487556;902.8104098139333;928.572856486024;1049.4700176410863;25758.48483030329;26390.47219055608;26494;26702.732972670026;26728.465430691667;909.8271328447706;912.977175570616;937.7983733497331;946.9857952130724;959.7024922274118;13021.023423243294;13091.869081309065;13886.93056534711;14626.926865365818;14992.625184370478;288137;293528;294670;295543;295884;47345;47614.28578571324;47639.76180119077;47648;47656.76171619189;1178.9174757767046;1192.2488832035763;1193.8746431624727;1200.963971080869;1203.837481939962;22030.779692202872;24685.62971555392;26393.472130557664;26781.732182677923;26839.597406038534;37185.814070929475;37454.438183426726;37457.25085498329;37466.43800342942;37504;173672;175603;175711;175738;326819;24147.154849580882;27970;28471.572926406534;28767;28884.42231155323;36922.076948076516;36956.076098097765;37686.2462750749;37764.81117594394;38243.617563825115;31425.685743142276;31671;32571.837140815092;32711.509327359632;32909;31834.36331273408;31931.521027184146;32351.838240808644;32402.83798580992;32503.349933001682;32400.513992289663;32877.67122328746;32986.34027319488;33112.33775324432;33176.50235246425;28554.286142846595;28962.161839473665;29357.853210734665;29464.558031629113;29473.705262947096;23141.305760827203;23466.178683745988;23522.64716029227;24788.876055619607;25376.238712838644 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: |2;jquery.html;333.45813053787595;340.4161862405974;340.83639852870624;342.3085367557534;343.99484007739903;12377.319247441386;12904.870951290484;15726.764098538531;15875.206239688026;16841.32634694611;11993.305140978286;14227.359768810402;14522.12867227967;14952.775708364383;14956.850431495683;4866.31871537985;5016.8996620067755;5021.14640511114;5022.773975171126;5024.598032157437;3605.36906041443;3733.4399840023943;4985.426675932278;5011.749412529359;5017.49825017499;5475.945240547603;5701.77192912285;5736.913946290809;5737.627054241482;5742.626729262605;5696.259486266779;5717.571182161334;6050.757969681207;6173.506119510474;6212.316645169028;5916.378780228057;5944.197533332988;5954.047352423635;5995.490383317423;6347.270063942659;20521.4869628259;20775.792242077536;20821.271255506137;21027.369178924655;21576.1369545218;1900.2019151956074;1922.0581914861616;1951.4633475794128;2025.8480613954011;2146.0450099705636;11292.435378231055;13365.599032029055;13519.932400338033;13703.69814867586;13720.862791372158;1757.9912100439544;1818.8999605021718;1825.771778527684;1839.4665546991357;1907.0845993922856;56738;61909.38090619081;63013.68493157551;63120.68439657818;63677;15137.697246055237;15182.392704291926;15239.3904243829;15257.237138143271;15418.691626167638;22968;23000;23210.071597136262;23232.3030309091;23289.7671023291;7978.960105199437;8100.473469224482;8116.147804480563;8155.10293867674;8198.508089514648;6608.537402381787;6627.4366678831875;6666.2333831609985;6682.665866706645;6685.298043705438;7431.888521672179;7474.364679002346;7476.813079673052;7509.624518774149;7679.462437629424;2333.673285739998;2828.533292006796;2885.79799414039;2967.9554806677916;3030.9848450757604;810.8418858322689;849.413904405958;869.5391442535466;944.3200895355333;963.2871674960479;14577.052491588012;15009;15334.846651533342;16150.676986460205;16389.180540972902;835.6573804740027;866.1901122450529;875.7449567364063;878.5343767803074;907.9546022698838;8983.281337492985;9037.638494460149;9121.77195570116;9248.121428464285;9342.813143737087;468389;482177;524233;524274;533571;68698;72154.27845721475;72755;73036.63481682664;73479.63260183665;1054.7363159210197;1062.3785085724937;1092.7322805912443;1125.2011072138873;1127.8646562412398;13790;13802.585922422344;14021.649458763612;14051.297435127999;14056.297185140907;32033.519497208028;32228.516572250966;33174.17064573405;33825.15437114092;34507.827460862536;42796.786016069724;43731.12537749163;43774.56225437705;43969;47746.28380574225;8354.206350396702;8647.178518040777;8661.696840610548;8688.522131282587;8727.476351418934;10334.121599664113;10388.220883433924;13022.609321720363;15966.60083497922;16462;13478;13606.591802245948;13626.659333516742;13695.657608559866;13980.091294065853;12924.224546526862;13137.146085504412;13366.93316533411;13400.396982136022;13808;12654.11421200544;12947.093703441045;13261;13806.93096534511;14180.290985450893;8663.350248731243;8698.782530436789;8706;8917;8948.463092214488;12938.094333396572;12987.220766754024;13041.282729449971;13555.728885422433;13685.589432317047 12:35:22 INFO - 2015-11-23 12:35:22,867 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1369.0621923982067;1410.8871290296777;1437.784332350148;1600.399850056229;1654.0985163086114;5732.398098199692;6624.966875165624;6762.695678694458;6772.085768421274;6774.491913106512;6593.901091483632;6792.592444453337;6793.762218322359;6793.898091528631;6800.183977922644;2087.2694556905076;2093.225506562574;2107.2729908181655;2110.3668899330214;2112.070688896888;2088.3943656339643;2092;2094.1309356616985;2101.663733802592;2116.820070294019;2084.6247675418417;2095.8952052397317;2101.9054142563546;2105.0211651582013;2114.3339847947923;2056.5681206946483;2065.5455799724036;2067.4934641012896;2070.265055905162;2070.8343332533436;2055.321743824534;2058.8558800883943;2089.039042040648;2091.550316681921;2094.2879420996783;5700.714964251771;5850.3564607893095;6721.327867213239;6760.019797129438;6778.152730908637;3612.584552776412;3686.3364594373;3917.0794863207125;3996.200759848013;4023.295923213426;2776.1393967870026;2800.187945495804;2839.2334069801245;2840.5029119904143;2866.956995645046;921.953902304882;933.3373304953491;938.3900464697932;946.3328353510827;1731.203646322693;9030.413023153475;9039.096090390974;9076.954615226947;9099.590518426687;9120.635174593075;3814.904627384338;3849.3263678856647;3925.4111883217747;3929.646331830149;3936.8622098226424;7492.887606685904;7512.661930213154;7512.699492020367;7518.511296765802;7521.548707077593;4257.8509752158525;4260.850870219528;4261.296886013773;4263.786810659517;4264.530901600821;3855.190410013872;3869.690424766012;3881.0491429599365;3895.7467764595776;3902.434147048662;3099.2097015260965;3105.6117985251844;3113.4551453495546;3129.2020534763947;3144.4654408750566;923.1599244687302;931.464407965409;932.8787257656461;933.1788026536605;940.238406890421;891.505214605887;937.329809186435;1154.261272785418;1174.442139983501;1181.6750393641817;6464.644444555594;6515.381038801306;6516.902246466307;6526.216853977458;6526.967365163144;981.8723565936383;1016.8017236638784;1024.1653052761976;1029.6998121022255;1044.383813550009;4813.663043586916;5161.767720452589;5192.402873669576;5201.817936372209;5209.0363282792805;7369.594672292968;7892.250236227549;7944.324732397811;8001.799955001172;8037.7990550235545;7852.568108753959;7940.960295198603;7942.3646108311195;7955.920440795634;7964.960175199203;6173.69131543421;6304.275008374004;6338.30278669346;6352.904706429407;6357.523185761086;6292.024736165901;6298.685065746786;6309.842253943504;6334.556581039283;6338.302786693368;7056.6471676417;7197.1363436387965;7277.854442911006;7281.745138920112;7285.417166626763;7251.539639206612;7449.068866391701;7498.812529686801;7525.962370188114;7531;5842.152887831156;5892.705364731832;5956.285245770362;5973.432523910222;5983.072623743326;6546.443552298108;6661.533692641468;6667.266600674019;6668;6674.232463266592;6026.548008899263;6179.969100154471;6226.034964580316;6228.719707613078;6376.713047912763;6102.633841969496;6146.692665366803;6224.190855188796;6244.843878903063;6253.405926436982;6224.595401298901;6304.842378940563;6337.112804207322;6345.079963405373;6357.809265722036;5829.300483941955;5871.970640146772;5879;5882.911756323573;5884.823455296348;5794.884102317846;5926.140709597171;5951.1073338999495;5965.224520812267;6015.368386319548 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: |4;prototype.html;315.391294801034;321.92273854274964;326.8447487443464;327.76400991286266;327.968842959919;5331.840044798658;5382.165764306529;5415.431379705128;5418.214358917954;5420.620556561047;5053.494650534944;5180.45605211452;5197.610179236553;5332.413434522209;5344.7862085516535;4204.32730763078;4229.7885105744745;4237.067845074079;4247.447831781864;4249.723767955088;4179.874603761892;4191.350340697197;4216.156768646268;4239.851605193819;4240.787960601973;3973.22522108189;4053.574374690659;4072.552019277877;4200.957990420087;4205.5163656179475;4176.874693759192;4193.6645068394455;4196.790160491963;4197.202531519001;4205.348171033479;3718.51659284294;3722.9627703722886;3723.6834869036165;3724;3729.030452082451;5193.948060519384;5205.06308864408;5213.087709650796;5222.686638801684;5227.973860130713;4756.952430475685;4861.124997500448;4871.853844384674;4872.4640289568115;4876.073546026244;5679.488846003838;5679.659220446786;5681.034224181899;5685.658860468385;5688.800891968761;4070.14526949341;4072.6538244249273;4074.4295798588223;4079.5920407959266;4086.3053280942013;5903.9114413283405;5904.675242861598;5952.375000624916;5975.402459754033;5991.670458124801;4115.794210289474;4116.794160291974;4197.412362269285;4200.537940826506;4217.7891105445215;4259.659227261874;4261.360795880642;4266.381374700651;4268.637165840876;4271.380649805761;4821.132196204647;4831.589314908272;4832;4832.782524786393;4838.03239352131;5671.716414179275;5679.630823996427;5684.37471878093;5687.374388817227;5687.800926967537;1413.6465883529117;1463.1879306984513;1467.8458761829854;1484.5917372722588;1512.7352713275134;981.9018098190267;990.3414229537277;998.9200863930868;1009.1926458833051;1010.1514727628827;4942.481039490874;4970;4973.229149481836;4975.925361119586;4978.5270399312;5798.623089499169;5830.650160990354;5840.766369345179;5848;5855.531557475391;4809.78355973982;4881.926771098437;4944.332515110414;4958.206686930074;4968.453470118284;3174.571432856581;3197.424463596575;3207.0859804955476;3210.293735378213;3212.0685001349348;5617.8033768817895;5619.494245517923;5627.971860140673;5633.661980281115;5642.774289028475;5985.461308482258;6109.358517355702;6109.541784366191;6120.693965301717;6127;5606.299212598426;5620.662760234399;5625.999999999918;5633.521150702154;5633.718314084279;5919.644821310735;5920.73356698941;5924.851878703067;5925.140854576149;5936.376680448663;5771.653700777799;5788.855278618068;5796.159556864315;5819.94180058194;5820.82537523875;5499.835004949858;5626.987142314259;5635.295588051494;5639.7744090237575;5646.632968857011;4107.137501124677;4109.219248342805;4110.486189226347;4110.794460276914;4118.485189351331;5938.6436813791315;5946.167536544801;5950.315713692808;5953.970230148821;5965.492933100735;5571.7492712828835;5726.541876649775;5726.914096288642;5732.856678582902;5737.770489180386;5722.227499287543;5725.770969161187;5731;5740;5743.9138412923;5610.074337734228;5610.775568977195;5611.6352437091455;5614.606977511535;5615.747291371817;5754;5765.4522820332;5776.480116789509;5777.3356064051495;5782.624129431573;5478.287822583198;5632.831015069554;5642.153676948491;5643.266375371176;5648.85877853057 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: |5;yui.html;659.347246226236;662.4832630548174;788.0582703669114;789.3685051958432;817.5952903312862;11001.779964400706;11245.493952772125;11316.26444281121;11324.377159256237;11347.262427942178;11605.709857253572;11791.115666325017;13471.73056538871;13742;13743.862561374408;633.9175907132067;805.2068712318362;817.9059408168077;818.1736446189332;818.5784321074651;627.3569591169065;787.2599756229126;799.7680672604938;800.8518424091561;801.3909428834099;823.9505629662209;845.3152946113637;846.3483117999137;846.8137009857821;847.6990668312752;594.9286085669726;600.4295918877041;819.5779173725537;831.6216121664628;840.4621042532784;612.4182027074253;613.2824595223599;615.6490800243863;616.1497133955158;616.4821549898062;11353.829692554618;11485.885141148565;11486.425678716114;11503.597374091867;11508.654740357802;10270.640527581574;10397.740056498573;10458;10813.83779243312;11453.0837532998;8689.784516762897;9107.772305692411;9110.27117830572;9234.215091717213;9261.073892610684;3244.6917542833394;3267.787593806419;3287.408266512027;3287.7698561100733;3332.4168270552555;36846.815765921;37552.43671344932;41055;41624;41751.791241043604;9094.727158185133;9238.445693258425;9342.859857102148;9380.108889655472;9445.102715242041;16174.110423926797;16350.75473867893;16353.754693679604;16371.754423683655;16390.180490975403;6326.466433388448;6359.459445947146;6439.452646525004;6451.032345148265;6499.252585952581;3667.284879448482;3677.1358730698266;3732.1789206375097;3744.0826997385816;3753.474513568103;2701.824381415241;2728.399752054545;2728.863556822151;2730.440259746747;2732.0437846753875;524.6327570700524;548.0737553534514;549;563.5519761789387;568.2385603291609;513.8895137545371;572.3160822816694;583.7460704593431;586.5454272938507;597.9282486101696;7634.31291183785;7791.80520486981;7847.882281765778;7908.600190749146;8191.8771218431775;564.6696682440736;574.1703238819948;597.8116893178635;607.5504126946028;610.0330975404034;3698.7780733156096;3777.0746167189213;3849.9807500962315;4031.5162180538523;4156.937645935313;43739.12521749611;43967;44026.55973440289;44108.3383749244;44237;42971.78514107409;43245.78377108094;43289.35065974013;43541.129177416275;43799.781001094794;39517.80241098776;40211;40242.59757402447;40443.98890027832;40744.185116298104;8086.474379165335;8169.101398846241;8200.195956889474;8241.876371854547;8247.21651443112;31115.533267001465;31502.842485787423;31691.52462713107;31741.68258317387;31983.68220290231;37581.24837503289;37603.24793504169;38476.42285365778;40198;40236.3964540538;9761.459493872366;10058.937917726702;10141.239407044353;10156.28905976604;10196.286259962028;11265.698655503218;11355.48900299472;11428.085753139563;11482.540698372306;11531.827022594836;10151.137153341753;10234.795304093728;10403.21975851799;10722.303050301705;10942.17933654963;9434.24526037929;10702.678919632424;10755.731106722082;10771.676849694522;11138.33170009802;8303.433637279664;9882.752931176778;9914.603415863285;10304.124149447382;10829.783404332027;8798.296136309207;8959.075397912775;9114.27085833145;9329.673461428818;9374.484403357881;9147.63409463614;9177;9244.676436324697;9268.53657317145;9332.626694932398 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,858 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310922860__endTimestamp 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,868 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4650.59 Median:4807.62 stddev:481.27 (10.0%) stddev-sans-first:455.86 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: Values: 2628.9 2719.9 2724.0 2748.3 2750.8 4467.0 4612.7 4672.1 4692.3 4708.6 4626.3 4626.4 4688.9 4692.6 4693.3 4324.5 4366.6 4390.3 4468.8 4517.0 4196.0 4419.0 4454.0 4490.6 4543.7 4244.0 4303.4 4313.1 4325.4 4330.4 4328.5 4344.9 4349.5 4380.3 4403.0 4138.5 4224.0 4304.2 4326.7 4369.8 4528.7 4547.7 4662.2 4685.3 4726.1 5031.1 5033.6 5059.6 5060.1 5093.2 4827.7 4978.5 5084.7 5097.8 5100.9 4583.3 4617.1 4622.1 4665.6 4676.6 5269.1 5297.0 5303.2 5306.8 5307.1 5074.8 5086.8 5093.7 5095.8 5147.7 4837.9 4944.6 4947.5 4979.7 5176.1 4860.4 4872.6 4891.3 4994.5 5028.0 4963.1 5015.2 5038.4 5072.8 5116.8 4044.5 4141.1 4238.4 4277.7 4323.3 3638.5 3648.8 3701.2 3728.6 3734.3 4391.6 4395.9 4406.2 4414.1 4437.4 4839.0 4942.3 5110.8 5112.8 5161.1 4297.9 4342.6 4354.0 4386.8 4405.3 4497.0 4535.8 4544.7 4546.2 4587.8 4851.5 4852.3 4854.3 4854.5 4893.5 4783.9 4882.6 4884.0 4979.5 5098.3 4803.9 4807.6 4809.8 4810.7 4863.2 4975.9 4979.7 4983.2 4995.0 5026.6 4826.3 4933.6 4939.9 4986.8 5022.8 4834.2 4844.7 4850.3 4913.1 4949.1 4849.8 4887.2 4891.2 4942.1 4943.5 4565.7 4638.6 4677.2 4761.0 4857.9 4911.1 4927.2 4931.8 4938.6 4945.1 4774.2 4812.9 4813.3 4823.0 4868.6 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40893.04 Median:31752.68 stddev:65764.67 (207.1%) stddev-sans-first:65879.44 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: Values: 561.0 571.6 574.2 579.7 581.1 28792.6 29384.6 37073.8 37571.4 37612.6 41159.8 41674.0 41730.6 41762.6 41781.6 6917.4 7016.9 7818.9 7908.8 7990.0 10051.0 10216.6 10256.0 10334.1 10338.2 10034.2 10133.3 10148.5 10164.7 10164.8 7253.3 7370.8 10007.1 10066.6 10388.2 9672.6 9786.9 9792.8 9792.9 9794.2 37249.4 37608.5 37745.8 37793.4 37854.4 2841.9 2969.4 2969.5 3028.2 3508.8 28261.4 28361.1 28661.0 28771.7 29013.0 3329.2 3340.9 3384.8 3387.1 3476.6 239613.0 239826.0 240221.0 240389.0 240517.0 50974.0 52176.2 55203.4 55880.4 55881.0 63629.7 63831.4 63863.7 64090.6 64284.0 13578.9 13775.3 13789.4 13798.7 13798.9 10171.4 10203.1 10239.3 10245.2 10253.8 18496.0 18536.3 18589.3 18613.6 18651.6 7065.6 7290.9 7377.2 7377.6 7386.7 843.6 891.6 902.8 928.6 1049.5 25758.5 26390.5 26494.0 26702.7 26728.5 909.8 913.0 937.8 947.0 959.7 13021.0 13091.9 13886.9 14626.9 14992.6 288137.0 293528.0 294670.0 295543.0 295884.0 47345.0 47614.3 47639.8 47648.0 47656.8 1178.9 1192.2 1193.9 1201.0 1203.8 22030.8 24685.6 26393.5 26781.7 26839.6 37185.8 37454.4 37457.3 37466.4 37504.0 173672.0 175603.0 175711.0 175738.0 326819.0 24147.2 27970.0 28471.6 28767.0 28884.4 36922.1 36956.1 37686.2 37764.8 38243.6 31425.7 31671.0 32571.8 32711.5 32909.0 31834.4 31931.5 32351.8 32402.8 32503.3 32400.5 32877.7 32986.3 33112.3 33176.5 28554.3 28962.2 29357.9 29464.6 29473.7 23141.3 23466.2 23522.6 24788.9 25376.2 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,870 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27811.34 Median:340.63 stddev:82758.39 (24295.9%) stddev-sans-first:82964.83 12:35:22 INFO - 2015-11-23 12:35:22,871 DEBUG : BROWSER_OUTPUT: Values: 333.5 340.4 340.8 342.3 344.0 12377.3 12904.9 15726.8 15875.2 16841.3 11993.3 14227.4 14522.1 14952.8 14956.9 4866.3 5016.9 5021.1 5022.8 5024.6 3605.4 3733.4 4985.4 5011.7 5017.5 5475.9 5701.8 5736.9 5737.6 5742.6 5696.3 5717.6 6050.8 6173.5 6212.3 5916.4 5944.2 5954.0 5995.5 6347.3 20521.5 20775.8 20821.3 21027.4 21576.1 1900.2 1922.1 1951.5 2025.8 2146.0 11292.4 13365.6 13519.9 13703.7 13720.9 1758.0 1818.9 1825.8 1839.5 1907.1 56738.0 61909.4 63013.7 63120.7 63677.0 15137.7 15182.4 15239.4 15257.2 15418.7 22968.0 23000.0 23210.1 23232.3 23289.8 7979.0 8100.5 8116.1 8155.1 8198.5 6608.5 6627.4 6666.2 6682.7 6685.3 7431.9 7474.4 7476.8 7509.6 7679.5 2333.7 2828.5 2885.8 2968.0 3031.0 810.8 849.4 869.5 944.3 963.3 14577.1 15009.0 15334.8 16150.7 16389.2 835.7 866.2 875.7 878.5 908.0 8983.3 9037.6 9121.8 9248.1 9342.8 468389.0 482177.0 524233.0 524274.0 533571.0 68698.0 72154.3 72755.0 73036.6 73479.6 1054.7 1062.4 1092.7 1125.2 1127.9 13790.0 13802.6 14021.6 14051.3 14056.3 32033.5 32228.5 33174.2 33825.2 34507.8 42796.8 43731.1 43774.6 43969.0 47746.3 8354.2 8647.2 8661.7 8688.5 8727.5 10334.1 10388.2 13022.6 15966.6 16462.0 13478.0 13606.6 13626.7 13695.7 13980.1 12924.2 13137.1 13366.9 13400.4 13808.0 12654.1 12947.1 13261.0 13806.9 14180.3 8663.4 8698.8 8706.0 8917.0 8948.5 12938.1 12987.2 13041.3 13555.7 13685.6 12:35:22 INFO - 2015-11-23 12:35:22,871 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4774.96 Median:6020.96 stddev:2379.13 (39.5%) stddev-sans-first:2372.03 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: Values: 1369.1 1410.9 1437.8 1600.4 1654.1 5732.4 6625.0 6762.7 6772.1 6774.5 6593.9 6792.6 6793.8 6793.9 6800.2 2087.3 2093.2 2107.3 2110.4 2112.1 2088.4 2092.0 2094.1 2101.7 2116.8 2084.6 2095.9 2101.9 2105.0 2114.3 2056.6 2065.5 2067.5 2070.3 2070.8 2055.3 2058.9 2089.0 2091.6 2094.3 5700.7 5850.4 6721.3 6760.0 6778.2 3612.6 3686.3 3917.1 3996.2 4023.3 2776.1 2800.2 2839.2 2840.5 2867.0 922.0 933.3 938.4 946.3 1731.2 9030.4 9039.1 9077.0 9099.6 9120.6 3814.9 3849.3 3925.4 3929.6 3936.9 7492.9 7512.7 7512.7 7518.5 7521.5 4257.9 4260.9 4261.3 4263.8 4264.5 3855.2 3869.7 3881.0 3895.7 3902.4 3099.2 3105.6 3113.5 3129.2 3144.5 923.2 931.5 932.9 933.2 940.2 891.5 937.3 1154.3 1174.4 1181.7 6464.6 6515.4 6516.9 6526.2 6527.0 981.9 1016.8 1024.2 1029.7 1044.4 4813.7 5161.8 5192.4 5201.8 5209.0 7369.6 7892.3 7944.3 8001.8 8037.8 7852.6 7941.0 7942.4 7955.9 7965.0 6173.7 6304.3 6338.3 6352.9 6357.5 6292.0 6298.7 6309.8 6334.6 6338.3 7056.6 7197.1 7277.9 7281.7 7285.4 7251.5 7449.1 7498.8 7526.0 7531.0 5842.2 5892.7 5956.3 5973.4 5983.1 6546.4 6661.5 6667.3 6668.0 6674.2 6026.5 6180.0 6226.0 6228.7 6376.7 6102.6 6146.7 6224.2 6244.8 6253.4 6224.6 6304.8 6337.1 6345.1 6357.8 5829.3 5872.0 5879.0 5882.9 5884.8 5794.9 5926.1 5951.1 5965.2 6015.4 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4740.71 Median:5332.13 stddev:1381.51 (25.9%) stddev-sans-first:1344.86 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: Values: 315.4 321.9 326.8 327.8 328.0 5331.8 5382.2 5415.4 5418.2 5420.6 5053.5 5180.5 5197.6 5332.4 5344.8 4204.3 4229.8 4237.1 4247.4 4249.7 4179.9 4191.4 4216.2 4239.9 4240.8 3973.2 4053.6 4072.6 4201.0 4205.5 4176.9 4193.7 4196.8 4197.2 4205.3 3718.5 3723.0 3723.7 3724.0 3729.0 5193.9 5205.1 5213.1 5222.7 5228.0 4757.0 4861.1 4871.9 4872.5 4876.1 5679.5 5679.7 5681.0 5685.7 5688.8 4070.1 4072.7 4074.4 4079.6 4086.3 5903.9 5904.7 5952.4 5975.4 5991.7 4115.8 4116.8 4197.4 4200.5 4217.8 4259.7 4261.4 4266.4 4268.6 4271.4 4821.1 4831.6 4832.0 4832.8 4838.0 5671.7 5679.6 5684.4 5687.4 5687.8 1413.6 1463.2 1467.8 1484.6 1512.7 981.9 990.3 998.9 1009.2 1010.2 4942.5 4970.0 4973.2 4975.9 4978.5 5798.6 5830.7 5840.8 5848.0 5855.5 4809.8 4881.9 4944.3 4958.2 4968.5 3174.6 3197.4 3207.1 3210.3 3212.1 5617.8 5619.5 5628.0 5633.7 5642.8 5985.5 6109.4 6109.5 6120.7 6127.0 5606.3 5620.7 5626.0 5633.5 5633.7 5919.6 5920.7 5924.9 5925.1 5936.4 5771.7 5788.9 5796.2 5819.9 5820.8 5499.8 5627.0 5635.3 5639.8 5646.6 4107.1 4109.2 4110.5 4110.8 4118.5 5938.6 5946.2 5950.3 5954.0 5965.5 5571.7 5726.5 5726.9 5732.9 5737.8 5722.2 5725.8 5731.0 5740.0 5743.9 5610.1 5610.8 5611.6 5614.6 5615.7 5754.0 5765.5 5776.5 5777.3 5782.6 5478.3 5632.8 5642.2 5643.3 5648.9 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: 12:35:22 INFO - 2015-11-23 12:35:22,872 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11994.52 Median:43883.39 stddev:13231.04 (30.2%) stddev-sans-first:13240.77 12:35:22 INFO - 2015-11-23 12:35:22,873 DEBUG : BROWSER_OUTPUT: Values: 659.3 662.5 788.1 789.4 817.6 11001.8 11245.5 11316.3 11324.4 11347.3 11605.7 11791.1 13471.7 13742.0 13743.9 633.9 805.2 817.9 818.2 818.6 627.4 787.3 799.8 800.9 801.4 824.0 845.3 846.3 846.8 847.7 594.9 600.4 819.6 831.6 840.5 612.4 613.3 615.6 616.1 616.5 11353.8 11485.9 11486.4 11503.6 11508.7 10270.6 10397.7 10458.0 10813.8 11453.1 8689.8 9107.8 9110.3 9234.2 9261.1 3244.7 3267.8 3287.4 3287.8 3332.4 36846.8 37552.4 41055.0 41624.0 41751.8 9094.7 9238.4 9342.9 9380.1 9445.1 16174.1 16350.8 16353.8 16371.8 16390.2 6326.5 6359.5 6439.5 6451.0 6499.3 3667.3 3677.1 3732.2 3744.1 3753.5 2701.8 2728.4 2728.9 2730.4 2732.0 524.6 548.1 549.0 563.6 568.2 513.9 572.3 583.7 586.5 597.9 7634.3 7791.8 7847.9 7908.6 8191.9 564.7 574.2 597.8 607.6 610.0 3698.8 3777.1 3850.0 4031.5 4156.9 43739.1 43967.0 44026.6 44108.3 44237.0 42971.8 43245.8 43289.4 43541.1 43799.8 39517.8 40211.0 40242.6 40444.0 40744.2 8086.5 8169.1 8200.2 8241.9 8247.2 31115.5 31502.8 31691.5 31741.7 31983.7 37581.2 37603.2 38476.4 40198.0 40236.4 9761.5 10058.9 10141.2 10156.3 10196.3 11265.7 11355.5 11428.1 11482.5 11531.8 10151.1 10234.8 10403.2 10722.3 10942.2 9434.2 10702.7 10755.7 10771.7 11138.3 8303.4 9882.8 9914.6 10304.1 10829.8 8798.3 8959.1 9114.3 9329.7 9374.5 9147.6 9177.0 9244.7 9268.5 9332.6 12:35:22 INFO - 2015-11-23 12:35:22,873 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:35:22 INFO - 2015-11-23 12:35:22,873 DEBUG : BROWSER_OUTPUT: 12:35:23 INFO - 2015-11-23 12:35:23,635 INFO : Browser exited with error code: 0 12:35:23 INFO - 2015-11-23 12:35:23,659 INFO : Completed test dromaeo_css (00:18:37) 12:35:23 INFO - 2015-11-23 12:35:23,659 INFO : Starting test kraken 12:35:23 INFO - 2015-11-23 12:35:23,659 DEBUG : operating with platform_type : linux_ 12:35:23 INFO - 2015-11-23 12:35:23,659 INFO : Initialising browser for kraken test... 12:35:23 INFO - 2015-11-23 12:35:23,665 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmL1o3/profile http://localhost:57435/getInfo.html 12:35:27 INFO - 2015-11-23 12:35:27,541 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:35:27 INFO - 2015-11-23 12:35:27,541 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:35:27 INFO - 2015-11-23 12:35:27,541 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:35:27 INFO - 2015-11-23 12:35:27,541 DEBUG : BROWSER_OUTPUT: __metrics 12:35:27 INFO - 2015-11-23 12:35:27,609 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 12:35:28 INFO - 2015-11-23 12:35:28,984 INFO : Browser initialized. 12:35:28 INFO - 2015-11-23 12:35:28,984 INFO : Running cycle 1/1 for kraken test... 12:35:28 INFO - 2015-11-23 12:35:28,985 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprmL1o3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:35:40 INFO - 2015-11-23 12:35:40,920 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 12:35:40 INFO - 2015-11-23 12:35:40,920 DEBUG : BROWSER_OUTPUT: 12:35:43 INFO - 2015-11-23 12:35:43,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57435/tests/kraken/driver.html?testName=audio-beat-detection) 12:35:44 INFO - 2015-11-23 12:35:44,115 DEBUG : BROWSER_OUTPUT: RSS: Main: 175792128 12:35:44 INFO - 2015-11-23 12:35:44,116 DEBUG : BROWSER_OUTPUT: 12:35:46 INFO - 2015-11-23 12:35:46,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57435/tests/kraken/driver.html?testName=audio-dft) 12:35:47 INFO - 2015-11-23 12:35:47,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 167096320 12:35:47 INFO - 2015-11-23 12:35:47,414 DEBUG : BROWSER_OUTPUT: 12:35:50 INFO - 2015-11-23 12:35:50,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57435/tests/kraken/driver.html?testName=audio-fft) 12:35:50 INFO - 2015-11-23 12:35:50,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 152907776 12:35:50 INFO - 2015-11-23 12:35:50,995 DEBUG : BROWSER_OUTPUT: 12:35:53 INFO - 2015-11-23 12:35:53,052 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57435/tests/kraken/driver.html?testName=audio-oscillator) 12:35:53 INFO - 2015-11-23 12:35:53,626 DEBUG : BROWSER_OUTPUT: RSS: Main: 155115520 12:35:53 INFO - 2015-11-23 12:35:53,626 DEBUG : BROWSER_OUTPUT: 12:35:55 INFO - 2015-11-23 12:35:55,828 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57435/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:35:56 INFO - 2015-11-23 12:35:56,395 DEBUG : BROWSER_OUTPUT: RSS: Main: 156295168 12:35:56 INFO - 2015-11-23 12:35:56,395 DEBUG : BROWSER_OUTPUT: 12:35:59 INFO - 2015-11-23 12:35:59,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57435/tests/kraken/driver.html?testName=imaging-darkroom) 12:35:59 INFO - 2015-11-23 12:35:59,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 155443200 12:35:59 INFO - 2015-11-23 12:35:59,987 DEBUG : BROWSER_OUTPUT: 12:36:03 INFO - 2015-11-23 12:36:03,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57435/tests/kraken/driver.html?testName=imaging-desaturate) 12:36:03 INFO - 2015-11-23 12:36:03,950 DEBUG : BROWSER_OUTPUT: RSS: Main: 155160576 12:36:03 INFO - 2015-11-23 12:36:03,950 DEBUG : BROWSER_OUTPUT: 12:36:06 INFO - 2015-11-23 12:36:06,788 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57435/tests/kraken/driver.html?testName=json-parse-financial) 12:36:07 INFO - 2015-11-23 12:36:07,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 157270016 12:36:07 INFO - 2015-11-23 12:36:07,361 DEBUG : BROWSER_OUTPUT: 12:36:09 INFO - 2015-11-23 12:36:09,110 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57435/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:36:09 INFO - 2015-11-23 12:36:09,672 DEBUG : BROWSER_OUTPUT: RSS: Main: 163143680 12:36:09 INFO - 2015-11-23 12:36:09,672 DEBUG : BROWSER_OUTPUT: 12:36:11 INFO - 2015-11-23 12:36:11,568 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:36:12 INFO - 2015-11-23 12:36:12,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 162439168 12:36:12 INFO - 2015-11-23 12:36:12,162 DEBUG : BROWSER_OUTPUT: 12:36:14 INFO - 2015-11-23 12:36:14,294 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:36:14 INFO - 2015-11-23 12:36:14,868 DEBUG : BROWSER_OUTPUT: RSS: Main: 172834816 12:36:14 INFO - 2015-11-23 12:36:14,868 DEBUG : BROWSER_OUTPUT: 12:36:17 INFO - 2015-11-23 12:36:17,383 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:36:17 INFO - 2015-11-23 12:36:17,984 DEBUG : BROWSER_OUTPUT: RSS: Main: 178020352 12:36:17 INFO - 2015-11-23 12:36:17,984 DEBUG : BROWSER_OUTPUT: 12:36:20 INFO - 2015-11-23 12:36:20,527 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:36:21 INFO - 2015-11-23 12:36:21,109 DEBUG : BROWSER_OUTPUT: RSS: Main: 175431680 12:36:21 INFO - 2015-11-23 12:36:21,110 DEBUG : BROWSER_OUTPUT: 12:36:22 INFO - 2015-11-23 12:36:22,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57435/tests/kraken/driver.html?testName=ai-astar) 12:36:23 INFO - 2015-11-23 12:36:23,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 234250240 12:36:23 INFO - 2015-11-23 12:36:23,095 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:36:23 INFO - 2015-11-23 12:36:23,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:36:23 INFO - 2015-11-23 12:36:23,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:36:23 INFO - 2015-11-23 12:36:23,098 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:36:23 INFO - 2015-11-23 12:36:23,098 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;113;105;112;113;113;102;113;104;111 12:36:23 INFO - 2015-11-23 12:36:23,098 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;133;152;169;132;151;154;133;175;139 12:36:23 INFO - 2015-11-23 12:36:23,098 DEBUG : BROWSER_OUTPUT: |2;audio-dft;160;161;161;161;160;160;163;161;164;161 12:36:23 INFO - 2015-11-23 12:36:23,099 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;95;72;72;73;101;91;72 12:36:23 INFO - 2015-11-23 12:36:23,099 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;92;132;91;90;91;129;90;91;127 12:36:23 INFO - 2015-11-23 12:36:23,099 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;110;110;109;110;109 12:36:23 INFO - 2015-11-23 12:36:23,100 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;147;146;150;146;147;147 12:36:23 INFO - 2015-11-23 12:36:23,100 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;96;95;95;95;95;95;95;95 12:36:23 INFO - 2015-11-23 12:36:23,100 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;69;71;70;69;70;69;77;67;67 12:36:23 INFO - 2015-11-23 12:36:23,100 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;70;69;69;69;69;69 12:36:23 INFO - 2015-11-23 12:36:23,101 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;82;90;83;81;84;84;92;83 12:36:23 INFO - 2015-11-23 12:36:23,101 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;135;125;126;120;125;120;123;120;127;119 12:36:23 INFO - 2015-11-23 12:36:23,101 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;138;150;138;146;140;146;149;141;136 12:36:23 INFO - 2015-11-23 12:36:23,102 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;69;68;68;70;69;67;68;70;69 12:36:23 INFO - 2015-11-23 12:36:23,102 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:36:23 INFO - 2015-11-23 12:36:23,102 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:36:23 INFO - 2015-11-23 12:36:23,102 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,987 12:36:23 INFO - 2015-11-23 12:36:23,103 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:36:23 INFO - 2015-11-23 12:36:23,103 DEBUG : BROWSER_OUTPUT: __startTimestamp1448310983096__endTimestamp 12:36:23 INFO - 2015-11-23 12:36:23,103 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,104 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:36:23 INFO - 2015-11-23 12:36:23,104 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.40 Median:112.50 stddev:4.30 (3.8%) stddev-sans-first:4.53 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 105.0 112.0 113.0 113.0 102.0 113.0 104.0 111.0 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.30 Median:153.00 stddev:15.09 (9.9%) stddev-sans-first:15.87 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: Values: 155.0 133.0 152.0 169.0 132.0 151.0 154.0 133.0 175.0 139.0 12:36:23 INFO - 2015-11-23 12:36:23,105 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.20 Median:161.00 stddev:1.32 (0.8%) stddev-sans-first:1.32 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: Values: 160.0 161.0 161.0 161.0 160.0 160.0 163.0 161.0 164.0 161.0 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.40 Median:72.50 stddev:11.40 (15.7%) stddev-sans-first:11.68 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 95.0 72.0 72.0 73.0 101.0 91.0 72.0 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.40 Median:91.00 stddev:18.63 (20.5%) stddev-sans-first:19.30 12:36:23 INFO - 2015-11-23 12:36:23,106 DEBUG : BROWSER_OUTPUT: Values: 91.0 92.0 132.0 91.0 90.0 91.0 129.0 90.0 91.0 127.0 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 110.0 110.0 109.0 110.0 109.0 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.80 Median:147.00 stddev:1.23 (0.8%) stddev-sans-first:1.27 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 147.0 146.0 150.0 146.0 147.0 147.0 12:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,107 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:36:23 INFO - 2015-11-23 12:36:23,107 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.90 Median:70.00 stddev:2.81 (4.0%) stddev-sans-first:2.98 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 71.0 70.0 69.0 70.0 69.0 77.0 67.0 67.0 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.00 Median:69.00 stddev:0.47 (0.7%) stddev-sans-first:0.33 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 70.0 69.0 69.0 69.0 69.0 69.0 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.30 Median:83.50 stddev:3.71 (4.4%) stddev-sans-first:3.74 12:36:23 INFO - 2015-11-23 12:36:23,108 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 82.0 90.0 83.0 81.0 84.0 84.0 92.0 83.0 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:125.00 stddev:4.83 (3.9%) stddev-sans-first:3.07 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: Values: 135.0 125.0 126.0 120.0 125.0 120.0 123.0 120.0 127.0 119.0 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.00 Median:146.00 stddev:4.99 (3.4%) stddev-sans-first:5.17 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: Values: 146.0 138.0 150.0 138.0 146.0 140.0 146.0 149.0 141.0 136.0 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:1.20 (1.7%) stddev-sans-first:1.00 12:36:23 INFO - 2015-11-23 12:36:23,109 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 68.0 68.0 70.0 69.0 67.0 68.0 70.0 69.0 12:36:23 INFO - 2015-11-23 12:36:23,110 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:36:23 INFO - 2015-11-23 12:36:23,110 DEBUG : BROWSER_OUTPUT: 12:36:24 INFO - 2015-11-23 12:36:24,055 INFO : Browser exited with error code: 0 12:36:24 INFO - 2015-11-23 12:36:24,107 INFO : Completed test kraken (00:01:00) 12:36:24 INFO - 2015-11-23 12:36:24,107 INFO : Starting test v8_7 12:36:24 INFO - 2015-11-23 12:36:24,107 DEBUG : operating with platform_type : linux_ 12:36:24 INFO - 2015-11-23 12:36:24,107 INFO : Initialising browser for v8_7 test... 12:36:24 INFO - 2015-11-23 12:36:24,113 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQi7K3M/profile http://localhost:57435/getInfo.html 12:36:27 INFO - 2015-11-23 12:36:27,987 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:36:27 INFO - 2015-11-23 12:36:27,987 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:36:27 INFO - 2015-11-23 12:36:27,987 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 12:36:27 INFO - 2015-11-23 12:36:27,987 DEBUG : BROWSER_OUTPUT: __metrics 12:36:28 INFO - 2015-11-23 12:36:28,104 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:29 INFO - 2015-11-23 12:36:29,332 INFO : Browser initialized. 12:36:29 INFO - 2015-11-23 12:36:29,332 INFO : Running cycle 1/1 for v8_7 test... 12:36:29 INFO - 2015-11-23 12:36:29,333 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpQi7K3M/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:36:41 INFO - 2015-11-23 12:36:41,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 142127104 12:36:41 INFO - 2015-11-23 12:36:41,347 DEBUG : BROWSER_OUTPUT: 12:37:02 INFO - 2015-11-23 12:37:02,781 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:57435/tests/v8_7/run.html (next: http://localhost:57435/tests/v8_7/run.html) 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: RSS: Main: 495169536 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:37:03 INFO - 2015-11-23 12:37:03,039 DEBUG : BROWSER_OUTPUT: |0;Richards;162.83992835043153 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.50490883590464 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5076.1421319796955 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1980.1980198019803 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |5;Earley;783.868441660141 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |8;Splay;631.7119393556538 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4845.410628019324 12:37:03 INFO - 2015-11-23 12:37:03,040 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: __startTimestamp1448311023032__endTimestamp 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.84 Median:162.84 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: Values: 162.8 12:37:03 INFO - 2015-11-23 12:37:03,041 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: Values: 191.4 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.50 Median:280.50 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: Values: 280.5 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5076.14 Median:5076.14 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: Values: 5076.1 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1980.20 Median:1980.20 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: Values: 1980.2 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:783.87 Median:783.87 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,042 DEBUG : BROWSER_OUTPUT: Values: 783.9 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: Values: 12219.5 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: Values: 26710.5 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:631.71 Median:631.71 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: Values: 631.7 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4845.41 Median:4845.41 stddev:0.00 (0.0%) 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: Values: 4845.4 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:37:03 INFO - 2015-11-23 12:37:03,043 DEBUG : BROWSER_OUTPUT: 12:37:03 INFO - 2015-11-23 12:37:03,864 INFO : Browser exited with error code: 0 12:37:03 INFO - 2015-11-23 12:37:03,880 INFO : Completed test v8_7 (00:00:39) 12:37:04 INFO - 2015-11-23 12:37:04,015 INFO : Completed test suite (00:20:18) 12:37:04 INFO - 2015-11-23 12:37:04,015 DEBUG : Working with test: dromaeo_css 12:37:04 INFO - 2015-11-23 12:37:04,016 DEBUG : Generating results file: dromaeo_css 12:37:04 INFO - 2015-11-23 12:37:04,017 DEBUG : Working with test: kraken 12:37:04 INFO - 2015-11-23 12:37:04,017 DEBUG : Generating results file: kraken 12:37:04 INFO - 2015-11-23 12:37:04,017 INFO : javascript benchmark 12:37:04 INFO - 2015-11-23 12:37:04,017 DEBUG : Working with test: v8_7 12:37:04 INFO - 2015-11-23 12:37:04,017 DEBUG : Generating results file: v8_7 12:37:04 INFO - 2015-11-23 12:37:04,018 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:04 INFO - 2015-11-23 12:37:04,074 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 12:37:04 INFO - 2015-11-23 12:37:04,074 DEBUG : process_Request line: dromaeo_css 6414.06 graph.html#tests=[[72,132,35]] 12:37:04 INFO - 2015-11-23 12:37:04,074 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:04 INFO - 2015-11-23 12:37:04,104 DEBUG : process_Request line: kraken 1513.40 graph.html#tests=[[232,132,35]] 12:37:04 INFO - 2015-11-23 12:37:04,105 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:37:04 INFO - 2015-11-23 12:37:04,133 DEBUG : process_Request line: v8_7 19753.71 graph.html#tests=[[230,132,35]] 12:37:04 INFO - 2015-11-23 12:37:04,134 INFO : javascript benchmark 12:37:04 INFO - 2015-11-23 12:37:04,138 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2628.934276643084, 2719.9184024479273, 2724.0, 2748.326659968307, 2750.8487033213164, 4467.0, 4612.723236605798, 4672.135654903841, 4692.343071969923, 4708.552687494687, 4626.329182268569, 4626.421697287839, 4688.859334219979, 4692.624590032798, 4693.342931989524, 4324.524302326741, 4366.585174408426, 4390.253656878331, 4468.798904049309, 4516.954830451687, 4195.979020104895, 4418.977905110486, 4453.953320969569, 4490.640748740093, 4543.6819422640265, 4243.978780106079, 4303.35449682547, 4313.137372525476, 4325.351197320396, 4330.372096046056, 4328.523862375137, 4344.913101737948, 4349.521552629209, 4380.34294855771, 4402.955970440286, 4138.461999940018, 4223.97888010558, 4304.246756817544, 4326.718763280377, 4369.759663218521, 4528.728276303399, 4547.727136371828, 4662.160811054009, 4685.273782563708, 4726.1020406122725, 5031.144705400091, 5033.644150709841, 5059.6458247922665, 5060.139776238048, 5093.1850903855575, 4827.686200396963, 4978.527039931237, 5084.694918304914, 5097.8215762448135, 5100.872478188038, 4583.289590113538, 4617.122746678154, 4622.052479241747, 4665.603423708955, 4676.649251306166, 5269.130593452114, 5297.046531624344, 5303.178007408857, 5306.8407947761625, 5307.124324486494, 5074.771635276422, 5086.77109530072, 5093.694378337312, 5095.770690318945, 5147.6911385317, 4837.879053023632, 4944.629152813553, 4947.529984651453, 4979.701217926936, 5176.068307704574, 4860.416749989953, 4872.610191184696, 4891.3396691446915, 4994.475580064113, 5028.0, 4963.057019166346, 5015.197568389113, 5038.395392552844, 5072.82245121419, 5116.820911268088, 4044.4742183515955, 4141.109661422808, 4238.449001629769, 4277.700560960765, 4323.308270676676, 3638.508801311789, 3648.835802388899, 3701.204241088179, 3728.5898551159353, 3734.2718169956597, 4391.604755572014, 4395.912081758347, 4406.228909940747, 4414.117176564636, 4437.356583295468, 4838.975805120952, 4942.258661200777, 5110.821121260738, 5112.769925353368, 5161.148410512224, 4297.914041719148, 4342.5874541918465, 4354.020345422318, 4386.8025938832825, 4405.31717583775, 4497.033137875307, 4535.773211339486, 4544.704594201433, 4546.204414227497, 4587.816487340469, 4851.539103785135, 4852.296417019513, 4854.271859221145, 4854.538818812207, 4893.510648935149, 4783.904321913612, 4882.60939124862, 4883.95116048835, 4979.452260251442, 5098.260752190838, 4803.903921921472, 4807.61539076866, 4809.759512024315, 4810.735409552508, 4863.197572400514, 4975.850724478271, 4979.651424400257, 4983.152864013199, 4994.9750251248515, 5026.59787217029, 4826.348442960156, 4933.6299777516115, 4939.851804445872, 4986.750662466789, 5022.773975171199, 4834.178189707828, 4844.709317440965, 4850.272459131017, 4913.06651736169, 4949.059678661043, 4849.781759820746, 4887.242477416006, 4891.241857512091, 4942.085714142895, 4943.505649435172, 4565.703229290086, 4638.628909687284, 4677.204875171161, 4761.0, 4857.902841943071, 4911.066897289504, 4927.236278376858, 4931.778069986787, 4938.555530002317, 4945.109880221595, 4774.236122220428, 4812.927806082982, 4813.278008298643, 4823.0, 4868.586170175575], "unit": "ms", "name": "dojo.html", "value": 4621.122588019212}, {"lowerIsBetter": false, "replicates": [561.0, 571.5941681406201, 574.2448679985819, 579.7420148034126, 581.0963951056108, 28792.56811147832, 29384.559231611544, 37073.81463092688, 37571.4364284536, 37612.62387376125, 41159.794201028955, 41674.0, 41730.58269417313, 41762.58237417625, 41781.58218417822, 6917.377436030756, 7016.859662806741, 7818.8827167592535, 7908.762737117896, 7989.960050199741, 10051.0, 10216.642417515388, 10256.0, 10334.121599664037, 10338.172946164326, 10034.247431442634, 10133.290669653128, 10148.49257537124, 10164.745881352952, 10164.847527287096, 7253.347198752138, 7370.815729606749, 10007.099361057504, 10066.647667331681, 10388.220883433773, 9672.56473458696, 9786.90213097867, 9792.804143917154, 9792.90207097927, 9794.16749576287, 37249.44125838114, 37608.49566017356, 37745.81127094347, 37793.43309850354, 37854.43218351727, 2841.9289517762013, 2969.4305773782244, 2969.5248760198265, 3028.242939265184, 3508.8421021054114, 28261.434771304663, 28361.054565314655, 28661.0, 28771.712282877113, 29013.0, 3329.167708072982, 3340.8997730068136, 3384.830758462067, 3387.0685561470546, 3476.617572067071, 239613.0, 239826.0, 240221.0, 240389.0, 240517.0, 50974.0, 52176.21735673968, 55203.44796551983, 55880.44119558833, 55881.0, 63629.68185159137, 63831.361686382545, 63863.68068159722, 64090.59094090647, 64284.0, 13578.93210533941, 13775.311234438239, 13789.379477923518, 13798.724025519434, 13798.862011379757, 10171.440570768531, 10203.132733717717, 10239.259325914612, 10245.231607629308, 10253.84619230712, 18496.0, 18536.258549658134, 18589.34937277189, 18613.627727445648, 18651.626967460576, 7065.6113913735235, 7290.927090729131, 7377.151627562899, 7377.594232317274, 7386.704531818775, 843.5529169540154, 891.5987805487556, 902.8104098139333, 928.572856486024, 1049.4700176410863, 25758.48483030329, 26390.47219055608, 26494.0, 26702.732972670026, 26728.465430691667, 909.8271328447706, 912.977175570616, 937.7983733497331, 946.9857952130724, 959.7024922274118, 13021.023423243294, 13091.869081309065, 13886.93056534711, 14626.926865365818, 14992.625184370478, 288137.0, 293528.0, 294670.0, 295543.0, 295884.0, 47345.0, 47614.28578571324, 47639.76180119077, 47648.0, 47656.76171619189, 1178.9174757767046, 1192.2488832035763, 1193.8746431624727, 1200.963971080869, 1203.837481939962, 22030.779692202872, 24685.62971555392, 26393.472130557664, 26781.732182677923, 26839.597406038534, 37185.814070929475, 37454.438183426726, 37457.25085498329, 37466.43800342942, 37504.0, 173672.0, 175603.0, 175711.0, 175738.0, 326819.0, 24147.154849580882, 27970.0, 28471.572926406534, 28767.0, 28884.42231155323, 36922.076948076516, 36956.076098097765, 37686.2462750749, 37764.81117594394, 38243.617563825115, 31425.685743142276, 31671.0, 32571.837140815092, 32711.509327359632, 32909.0, 31834.36331273408, 31931.521027184146, 32351.838240808644, 32402.83798580992, 32503.349933001682, 32400.513992289663, 32877.67122328746, 32986.34027319488, 33112.33775324432, 33176.50235246425, 28554.286142846595, 28962.161839473665, 29357.853210734665, 29464.558031629113, 29473.705262947096, 23141.305760827203, 23466.178683745988, 23522.64716029227, 24788.876055619607, 25376.238712838644], "unit": "ms", "name": "ext.html", "value": 17119.437932635232}, {"lowerIsBetter": false, "replicates": [333.45813053787595, 340.4161862405974, 340.83639852870624, 342.3085367557534, 343.99484007739903, 12377.319247441386, 12904.870951290484, 15726.764098538531, 15875.206239688026, 16841.32634694611, 11993.305140978286, 14227.359768810402, 14522.12867227967, 14952.775708364383, 14956.850431495683, 4866.31871537985, 5016.8996620067755, 5021.14640511114, 5022.773975171126, 5024.598032157437, 3605.36906041443, 3733.4399840023943, 4985.426675932278, 5011.749412529359, 5017.49825017499, 5475.945240547603, 5701.77192912285, 5736.913946290809, 5737.627054241482, 5742.626729262605, 5696.259486266779, 5717.571182161334, 6050.757969681207, 6173.506119510474, 6212.316645169028, 5916.378780228057, 5944.197533332988, 5954.047352423635, 5995.490383317423, 6347.270063942659, 20521.4869628259, 20775.792242077536, 20821.271255506137, 21027.369178924655, 21576.1369545218, 1900.2019151956074, 1922.0581914861616, 1951.4633475794128, 2025.8480613954011, 2146.0450099705636, 11292.435378231055, 13365.599032029055, 13519.932400338033, 13703.69814867586, 13720.862791372158, 1757.9912100439544, 1818.8999605021718, 1825.771778527684, 1839.4665546991357, 1907.0845993922856, 56738.0, 61909.38090619081, 63013.68493157551, 63120.68439657818, 63677.0, 15137.697246055237, 15182.392704291926, 15239.3904243829, 15257.237138143271, 15418.691626167638, 22968.0, 23000.0, 23210.071597136262, 23232.3030309091, 23289.7671023291, 7978.960105199437, 8100.473469224482, 8116.147804480563, 8155.10293867674, 8198.508089514648, 6608.537402381787, 6627.4366678831875, 6666.2333831609985, 6682.665866706645, 6685.298043705438, 7431.888521672179, 7474.364679002346, 7476.813079673052, 7509.624518774149, 7679.462437629424, 2333.673285739998, 2828.533292006796, 2885.79799414039, 2967.9554806677916, 3030.9848450757604, 810.8418858322689, 849.413904405958, 869.5391442535466, 944.3200895355333, 963.2871674960479, 14577.052491588012, 15009.0, 15334.846651533342, 16150.676986460205, 16389.180540972902, 835.6573804740027, 866.1901122450529, 875.7449567364063, 878.5343767803074, 907.9546022698838, 8983.281337492985, 9037.638494460149, 9121.77195570116, 9248.121428464285, 9342.813143737087, 468389.0, 482177.0, 524233.0, 524274.0, 533571.0, 68698.0, 72154.27845721475, 72755.0, 73036.63481682664, 73479.63260183665, 1054.7363159210197, 1062.3785085724937, 1092.7322805912443, 1125.2011072138873, 1127.8646562412398, 13790.0, 13802.585922422344, 14021.649458763612, 14051.297435127999, 14056.297185140907, 32033.519497208028, 32228.516572250966, 33174.17064573405, 33825.15437114092, 34507.827460862536, 42796.786016069724, 43731.12537749163, 43774.56225437705, 43969.0, 47746.28380574225, 8354.206350396702, 8647.178518040777, 8661.696840610548, 8688.522131282587, 8727.476351418934, 10334.121599664113, 10388.220883433924, 13022.609321720363, 15966.60083497922, 16462.0, 13478.0, 13606.591802245948, 13626.659333516742, 13695.657608559866, 13980.091294065853, 12924.224546526862, 13137.146085504412, 13366.93316533411, 13400.396982136022, 13808.0, 12654.11421200544, 12947.093703441045, 13261.0, 13806.93096534511, 14180.290985450893, 8663.350248731243, 8698.782530436789, 8706.0, 8917.0, 8948.463092214488, 12938.094333396572, 12987.220766754024, 13041.282729449971, 13555.728885422433, 13685.589432317047], "unit": "ms", "name": "jquery.html", "value": 9009.879582286287}, {"lowerIsBetter": false, "replicates": [1369.0621923982067, 1410.8871290296777, 1437.784332350148, 1600.399850056229, 1654.0985163086114, 5732.398098199692, 6624.966875165624, 6762.695678694458, 6772.085768421274, 6774.491913106512, 6593.901091483632, 6792.592444453337, 6793.762218322359, 6793.898091528631, 6800.183977922644, 2087.2694556905076, 2093.225506562574, 2107.2729908181655, 2110.3668899330214, 2112.070688896888, 2088.3943656339643, 2092.0, 2094.1309356616985, 2101.663733802592, 2116.820070294019, 2084.6247675418417, 2095.8952052397317, 2101.9054142563546, 2105.0211651582013, 2114.3339847947923, 2056.5681206946483, 2065.5455799724036, 2067.4934641012896, 2070.265055905162, 2070.8343332533436, 2055.321743824534, 2058.8558800883943, 2089.039042040648, 2091.550316681921, 2094.2879420996783, 5700.714964251771, 5850.3564607893095, 6721.327867213239, 6760.019797129438, 6778.152730908637, 3612.584552776412, 3686.3364594373, 3917.0794863207125, 3996.200759848013, 4023.295923213426, 2776.1393967870026, 2800.187945495804, 2839.2334069801245, 2840.5029119904143, 2866.956995645046, 921.953902304882, 933.3373304953491, 938.3900464697932, 946.3328353510827, 1731.203646322693, 9030.413023153475, 9039.096090390974, 9076.954615226947, 9099.590518426687, 9120.635174593075, 3814.904627384338, 3849.3263678856647, 3925.4111883217747, 3929.646331830149, 3936.8622098226424, 7492.887606685904, 7512.661930213154, 7512.699492020367, 7518.511296765802, 7521.548707077593, 4257.8509752158525, 4260.850870219528, 4261.296886013773, 4263.786810659517, 4264.530901600821, 3855.190410013872, 3869.690424766012, 3881.0491429599365, 3895.7467764595776, 3902.434147048662, 3099.2097015260965, 3105.6117985251844, 3113.4551453495546, 3129.2020534763947, 3144.4654408750566, 923.1599244687302, 931.464407965409, 932.8787257656461, 933.1788026536605, 940.238406890421, 891.505214605887, 937.329809186435, 1154.261272785418, 1174.442139983501, 1181.6750393641817, 6464.644444555594, 6515.381038801306, 6516.902246466307, 6526.216853977458, 6526.967365163144, 981.8723565936383, 1016.8017236638784, 1024.1653052761976, 1029.6998121022255, 1044.383813550009, 4813.663043586916, 5161.767720452589, 5192.402873669576, 5201.817936372209, 5209.0363282792805, 7369.594672292968, 7892.250236227549, 7944.324732397811, 8001.799955001172, 8037.7990550235545, 7852.568108753959, 7940.960295198603, 7942.3646108311195, 7955.920440795634, 7964.960175199203, 6173.69131543421, 6304.275008374004, 6338.30278669346, 6352.904706429407, 6357.523185761086, 6292.024736165901, 6298.685065746786, 6309.842253943504, 6334.556581039283, 6338.302786693368, 7056.6471676417, 7197.1363436387965, 7277.854442911006, 7281.745138920112, 7285.417166626763, 7251.539639206612, 7449.068866391701, 7498.812529686801, 7525.962370188114, 7531.0, 5842.152887831156, 5892.705364731832, 5956.285245770362, 5973.432523910222, 5983.072623743326, 6546.443552298108, 6661.533692641468, 6667.266600674019, 6668.0, 6674.232463266592, 6026.548008899263, 6179.969100154471, 6226.034964580316, 6228.719707613078, 6376.713047912763, 6102.633841969496, 6146.692665366803, 6224.190855188796, 6244.843878903063, 6253.405926436982, 6224.595401298901, 6304.842378940563, 6337.112804207322, 6345.079963405373, 6357.809265722036, 5829.300483941955, 5871.970640146772, 5879.0, 5882.911756323573, 5884.823455296348, 5794.884102317846, 5926.140709597171, 5951.1073338999495, 5965.224520812267, 6015.368386319548], "unit": "ms", "name": "mootools.html", "value": 3983.8731784102447}, {"lowerIsBetter": false, "replicates": [315.391294801034, 321.92273854274964, 326.8447487443464, 327.76400991286266, 327.968842959919, 5331.840044798658, 5382.165764306529, 5415.431379705128, 5418.214358917954, 5420.620556561047, 5053.494650534944, 5180.45605211452, 5197.610179236553, 5332.413434522209, 5344.7862085516535, 4204.32730763078, 4229.7885105744745, 4237.067845074079, 4247.447831781864, 4249.723767955088, 4179.874603761892, 4191.350340697197, 4216.156768646268, 4239.851605193819, 4240.787960601973, 3973.22522108189, 4053.574374690659, 4072.552019277877, 4200.957990420087, 4205.5163656179475, 4176.874693759192, 4193.6645068394455, 4196.790160491963, 4197.202531519001, 4205.348171033479, 3718.51659284294, 3722.9627703722886, 3723.6834869036165, 3724.0, 3729.030452082451, 5193.948060519384, 5205.06308864408, 5213.087709650796, 5222.686638801684, 5227.973860130713, 4756.952430475685, 4861.124997500448, 4871.853844384674, 4872.4640289568115, 4876.073546026244, 5679.488846003838, 5679.659220446786, 5681.034224181899, 5685.658860468385, 5688.800891968761, 4070.14526949341, 4072.6538244249273, 4074.4295798588223, 4079.5920407959266, 4086.3053280942013, 5903.9114413283405, 5904.675242861598, 5952.375000624916, 5975.402459754033, 5991.670458124801, 4115.794210289474, 4116.794160291974, 4197.412362269285, 4200.537940826506, 4217.7891105445215, 4259.659227261874, 4261.360795880642, 4266.381374700651, 4268.637165840876, 4271.380649805761, 4821.132196204647, 4831.589314908272, 4832.0, 4832.782524786393, 4838.03239352131, 5671.716414179275, 5679.630823996427, 5684.37471878093, 5687.374388817227, 5687.800926967537, 1413.6465883529117, 1463.1879306984513, 1467.8458761829854, 1484.5917372722588, 1512.7352713275134, 981.9018098190267, 990.3414229537277, 998.9200863930868, 1009.1926458833051, 1010.1514727628827, 4942.481039490874, 4970.0, 4973.229149481836, 4975.925361119586, 4978.5270399312, 5798.623089499169, 5830.650160990354, 5840.766369345179, 5848.0, 5855.531557475391, 4809.78355973982, 4881.926771098437, 4944.332515110414, 4958.206686930074, 4968.453470118284, 3174.571432856581, 3197.424463596575, 3207.0859804955476, 3210.293735378213, 3212.0685001349348, 5617.8033768817895, 5619.494245517923, 5627.971860140673, 5633.661980281115, 5642.774289028475, 5985.461308482258, 6109.358517355702, 6109.541784366191, 6120.693965301717, 6127.0, 5606.299212598426, 5620.662760234399, 5625.999999999918, 5633.521150702154, 5633.718314084279, 5919.644821310735, 5920.73356698941, 5924.851878703067, 5925.140854576149, 5936.376680448663, 5771.653700777799, 5788.855278618068, 5796.159556864315, 5819.94180058194, 5820.82537523875, 5499.835004949858, 5626.987142314259, 5635.295588051494, 5639.7744090237575, 5646.632968857011, 4107.137501124677, 4109.219248342805, 4110.486189226347, 4110.794460276914, 4118.485189351331, 5938.6436813791315, 5946.167536544801, 5950.315713692808, 5953.970230148821, 5965.492933100735, 5571.7492712828835, 5726.541876649775, 5726.914096288642, 5732.856678582902, 5737.770489180386, 5722.227499287543, 5725.770969161187, 5731.0, 5740.0, 5743.9138412923, 5610.074337734228, 5610.775568977195, 5611.6352437091455, 5614.606977511535, 5615.747291371817, 5754.0, 5765.4522820332, 5776.480116789509, 5777.3356064051495, 5782.624129431573, 5478.287822583198, 5632.831015069554, 5642.153676948491, 5643.266375371176, 5648.85877853057], "unit": "ms", "name": "prototype.html", "value": 4300.4700253029005}, {"lowerIsBetter": false, "replicates": [659.347246226236, 662.4832630548174, 788.0582703669114, 789.3685051958432, 817.5952903312862, 11001.779964400706, 11245.493952772125, 11316.26444281121, 11324.377159256237, 11347.262427942178, 11605.709857253572, 11791.115666325017, 13471.73056538871, 13742.0, 13743.862561374408, 633.9175907132067, 805.2068712318362, 817.9059408168077, 818.1736446189332, 818.5784321074651, 627.3569591169065, 787.2599756229126, 799.7680672604938, 800.8518424091561, 801.3909428834099, 823.9505629662209, 845.3152946113637, 846.3483117999137, 846.8137009857821, 847.6990668312752, 594.9286085669726, 600.4295918877041, 819.5779173725537, 831.6216121664628, 840.4621042532784, 612.4182027074253, 613.2824595223599, 615.6490800243863, 616.1497133955158, 616.4821549898062, 11353.829692554618, 11485.885141148565, 11486.425678716114, 11503.597374091867, 11508.654740357802, 10270.640527581574, 10397.740056498573, 10458.0, 10813.83779243312, 11453.0837532998, 8689.784516762897, 9107.772305692411, 9110.27117830572, 9234.215091717213, 9261.073892610684, 3244.6917542833394, 3267.787593806419, 3287.408266512027, 3287.7698561100733, 3332.4168270552555, 36846.815765921, 37552.43671344932, 41055.0, 41624.0, 41751.791241043604, 9094.727158185133, 9238.445693258425, 9342.859857102148, 9380.108889655472, 9445.102715242041, 16174.110423926797, 16350.75473867893, 16353.754693679604, 16371.754423683655, 16390.180490975403, 6326.466433388448, 6359.459445947146, 6439.452646525004, 6451.032345148265, 6499.252585952581, 3667.284879448482, 3677.1358730698266, 3732.1789206375097, 3744.0826997385816, 3753.474513568103, 2701.824381415241, 2728.399752054545, 2728.863556822151, 2730.440259746747, 2732.0437846753875, 524.6327570700524, 548.0737553534514, 549.0, 563.5519761789387, 568.2385603291609, 513.8895137545371, 572.3160822816694, 583.7460704593431, 586.5454272938507, 597.9282486101696, 7634.31291183785, 7791.80520486981, 7847.882281765778, 7908.600190749146, 8191.8771218431775, 564.6696682440736, 574.1703238819948, 597.8116893178635, 607.5504126946028, 610.0330975404034, 3698.7780733156096, 3777.0746167189213, 3849.9807500962315, 4031.5162180538523, 4156.937645935313, 43739.12521749611, 43967.0, 44026.55973440289, 44108.3383749244, 44237.0, 42971.78514107409, 43245.78377108094, 43289.35065974013, 43541.129177416275, 43799.781001094794, 39517.80241098776, 40211.0, 40242.59757402447, 40443.98890027832, 40744.185116298104, 8086.474379165335, 8169.101398846241, 8200.195956889474, 8241.876371854547, 8247.21651443112, 31115.533267001465, 31502.842485787423, 31691.52462713107, 31741.68258317387, 31983.68220290231, 37581.24837503289, 37603.24793504169, 38476.42285365778, 40198.0, 40236.3964540538, 9761.459493872366, 10058.937917726702, 10141.239407044353, 10156.28905976604, 10196.286259962028, 11265.698655503218, 11355.48900299472, 11428.085753139563, 11482.540698372306, 11531.827022594836, 10151.137153341753, 10234.795304093728, 10403.21975851799, 10722.303050301705, 10942.17933654963, 9434.24526037929, 10702.678919632424, 10755.731106722082, 10771.676849694522, 11138.33170009802, 8303.433637279664, 9882.752931176778, 9914.603415863285, 10304.124149447382, 10829.783404332027, 8798.296136309207, 8959.075397912775, 9114.27085833145, 9329.673461428818, 9374.484403357881, 9147.63409463614, 9177.0, 9244.676436324697, 9268.53657317145, 9332.626694932398], "unit": "ms", "name": "yui.html", "value": 5701.288099303311}], "name": "dromaeo_css", "value": 6414.059359312662}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [108.0, 113.0, 105.0, 112.0, 113.0, 113.0, 102.0, 113.0, 104.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 109.4}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 152.0, 169.0, 132.0, 151.0, 154.0, 133.0, 175.0, 139.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.3}, {"lowerIsBetter": true, "replicates": [160.0, 161.0, 161.0, 161.0, 160.0, 160.0, 163.0, 161.0, 164.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.2}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 95.0, 72.0, 72.0, 73.0, 101.0, 91.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 80.4}, {"lowerIsBetter": true, "replicates": [91.0, 92.0, 132.0, 91.0, 90.0, 91.0, 129.0, 90.0, 91.0, 127.0], "unit": "ms", "name": "audio-oscillator", "value": 102.4}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 146.0, 150.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.8}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 71.0, 70.0, 69.0, 70.0, 69.0, 77.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 69.9}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.0}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 82.0, 90.0, 83.0, 81.0, 84.0, 84.0, 92.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.3}, {"lowerIsBetter": true, "replicates": [135.0, 125.0, 126.0, 120.0, 125.0, 120.0, 123.0, 120.0, 127.0, 119.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [146.0, 138.0, 150.0, 138.0, 146.0, 140.0, 146.0, 149.0, 141.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.0}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 68.0, 68.0, 70.0, 69.0, 67.0, 68.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1513.4}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.83992835043153], "unit": "score", "name": "Richards", "value": 216.78958200000002}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [280.50490883590464], "unit": "score", "name": "Encrypt", "value": 948.9352650000003}, {"lowerIsBetter": false, "replicates": [5076.1421319796955], "unit": "score", "name": "Decrypt", "value": 52.43765699999998}, {"lowerIsBetter": false, "replicates": [1980.1980198019803], "unit": "score", "name": "RayTrace", "value": 373.6944450000001}, {"lowerIsBetter": false, "replicates": [783.868441660141], "unit": "score", "name": "Earley", "value": 850.2230279720281}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [631.7119393556538], "unit": "score", "name": "Splay", "value": 129.000253}, {"lowerIsBetter": false, "replicates": [4845.410628019324], "unit": "score", "name": "NavierStokes", "value": 306.26919242273203}], "name": "v8_7", "value": 19753.70595563597}]} 12:37:04 INFO - RETURN: dromaeo_css: 6414.06 12:37:04 INFO - RETURN: kraken: 1513.40 12:37:04 INFO - RETURN: v8_7: 19753.71 12:37:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19753.71"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1513.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6414.06"}}} 12:37:04 INFO - Return code: 0 12:37:04 INFO - # TBPL SUCCESS # 12:37:04 INFO - Running post-action listener: _resource_record_post_action 12:37:04 INFO - Running post-run listener: _resource_record_post_run 12:37:05 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513249280; Read time: 12; Write time: 435232 12:37:05 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 136912896; Read time: 0; Write time: 114764 12:37:05 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 345141248; Read time: 0; Write time: 306844 12:37:05 INFO - Running post-run listener: _upload_blobber_files 12:37:05 INFO - Blob upload gear active. 12:37:05 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:37:05 INFO - Copying logs to upload dir... 12:37:05 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1260.419858 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2015-11-23 12:37:04.564271) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:04.567612) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 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.009902 build_url: 'https://queue.taskcluster.net/v1/task/d8NPS8_UQdC0BwIB3Ad9cA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:04.619621) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:04.619960) ========= 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=6b42339bb4b96cfc3b1ae7e5000001a3-1448309762.269807-449224249 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004590 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 12:37:04.670174) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:04.670579) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 12:37:04.670955) ========= ========= Total master_lag: 0.21 =========