builder: fx-team_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-055 starttime: 1448441433.5 results: success (0) buildid: 20151124235532 builduid: c2fa78bb1d4f4e31a962518788cf7108 revision: e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.496924) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.497349) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.497629) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006562 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.518601) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.518883) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.553900) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.554203) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.607435) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.607708) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.608022) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.608289) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 00:50:33-- 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% 228M=0s 2015-11-25 00:50:34 (228 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.182689 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.803030) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.803312) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017263 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:33.853905) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 00:50:33.854214) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b --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 e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b --destination scripts --debug'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 00:50:34,203 truncating revision to first 12 chars 2015-11-25 00:50:34,203 Setting DEBUG logging. 2015-11-25 00:50:34,204 attempt 1/10 2015-11-25 00:50:34,204 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/e799e37d4bd2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 00:50:35,665 unpacking tar archive at: fx-team-e799e37d4bd2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.722194 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 00:50:35.589132) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:35.589507) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:35.598118) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:35.598437) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 00:50:35.598836) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-25 00:50:35.599112) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team-Non-PGO'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 00:50:36 INFO - MultiFileLogger online at 20151125 00:50:36 in /builds/slave/test 00:50:36 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 00:50:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 00:50:36 INFO - {'append_to_log': False, 00:50:36 INFO - 'base_work_dir': '/builds/slave/test', 00:50:36 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 00:50:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 00:50:36 INFO - 'branch': 'Fx-Team-Non-PGO', 00:50:36 INFO - 'buildbot_json_path': 'buildprops.json', 00:50:36 INFO - 'config_files': ('talos/linux_config.py',), 00:50:36 INFO - 'default_actions': ('clobber', 00:50:36 INFO - 'read-buildbot-config', 00:50:36 INFO - 'download-and-extract', 00:50:36 INFO - 'populate-webroot', 00:50:36 INFO - 'create-virtualenv', 00:50:36 INFO - 'install', 00:50:36 INFO - 'run-tests'), 00:50:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 00:50:36 INFO - 'download_minidump_stackwalk': True, 00:50:36 INFO - 'download_symbols': 'ondemand', 00:50:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 00:50:36 INFO - 'tooltool.py': '/tools/tooltool.py', 00:50:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 00:50:36 INFO - '/tools/misc-python/virtualenv.py')}, 00:50:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 00:50:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 00:50:36 INFO - 'installer_path': 'installer.exe', 00:50:36 INFO - 'log_level': 'info', 00:50:36 INFO - 'log_name': 'talos', 00:50:36 INFO - 'log_to_console': True, 00:50:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 00:50:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 00:50:36 INFO - 'opt_config_files': (), 00:50:36 INFO - 'pip_index': False, 00:50:36 INFO - 'sps_profile': False, 00:50:36 INFO - 'sps_profile_interval': 0, 00:50:36 INFO - 'suite': 'dromaeojs', 00:50:36 INFO - 'system_bits': '64', 00:50:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 00:50:36 INFO - 'title': 'talos-linux64-ix-055', 00:50:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 00:50:36 INFO - 'use_talos_json': True, 00:50:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 00:50:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 00:50:36 INFO - 'work_dir': 'build'} 00:50:36 INFO - ##### 00:50:36 INFO - ##### Running clobber step. 00:50:36 INFO - ##### 00:50:36 INFO - Running pre-action listener: _resource_record_pre_action 00:50:36 INFO - Running main action method: clobber 00:50:36 INFO - rmtree: /builds/slave/test/build 00:50:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 00:50:36 INFO - Running post-action listener: _resource_record_post_action 00:50:36 INFO - ##### 00:50:36 INFO - ##### Running read-buildbot-config step. 00:50:36 INFO - ##### 00:50:36 INFO - Running pre-action listener: _resource_record_pre_action 00:50:36 INFO - Running main action method: read_buildbot_config 00:50:36 INFO - Using buildbot properties: 00:50:36 INFO - { 00:50:36 INFO - "properties": { 00:50:36 INFO - "buildnumber": 921, 00:50:36 INFO - "product": "firefox", 00:50:36 INFO - "script_repo_revision": "production", 00:50:36 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs", 00:50:36 INFO - "repository": "", 00:50:36 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs", 00:50:36 INFO - "buildid": "20151124235532", 00:50:36 INFO - "slavename": "talos-linux64-ix-055", 00:50:36 INFO - "pgo_build": "False", 00:50:36 INFO - "basedir": "/builds/slave/test", 00:50:36 INFO - "project": "", 00:50:36 INFO - "platform": "ubuntu64_hw", 00:50:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 00:50:36 INFO - "slavebuilddir": "test", 00:50:36 INFO - "scheduler": "tests-fx-team-linux64-talos", 00:50:36 INFO - "branch": "fx-team", 00:50:36 INFO - "repo_path": "integration/fx-team", 00:50:36 INFO - "stage_platform": "linux64", 00:50:36 INFO - "builduid": "c2fa78bb1d4f4e31a962518788cf7108", 00:50:36 INFO - "revision": "e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b" 00:50:36 INFO - }, 00:50:36 INFO - "sourcestamp": { 00:50:36 INFO - "repository": "", 00:50:36 INFO - "hasPatch": false, 00:50:36 INFO - "project": "", 00:50:36 INFO - "branch": "fx-team-linux64-talos", 00:50:36 INFO - "changes": [ 00:50:36 INFO - { 00:50:36 INFO - "category": null, 00:50:36 INFO - "files": [ 00:50:36 INFO - { 00:50:36 INFO - "url": null, 00:50:36 INFO - "name": "https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 00:50:36 INFO - } 00:50:36 INFO - ], 00:50:36 INFO - "repository": "", 00:50:36 INFO - "rev": "e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b", 00:50:36 INFO - "who": "cbook@mozilla.com", 00:50:36 INFO - "when": 1448441387, 00:50:36 INFO - "number": 6704587, 00:50:36 INFO - "comments": "Bug 1216972 - MediaManager AsyncShutdown for content processes. r=jesup", 00:50:36 INFO - "project": "", 00:50:36 INFO - "at": "Wed 25 Nov 2015 00:49:47", 00:50:36 INFO - "branch": "fx-team-linux64-talos", 00:50:36 INFO - "revlink": "", 00:50:36 INFO - "properties": [ 00:50:36 INFO - [ 00:50:36 INFO - "buildid", 00:50:36 INFO - "20151124235532", 00:50:36 INFO - "Change" 00:50:36 INFO - ], 00:50:36 INFO - [ 00:50:36 INFO - "builduid", 00:50:36 INFO - "c2fa78bb1d4f4e31a962518788cf7108", 00:50:36 INFO - "Change" 00:50:36 INFO - ], 00:50:36 INFO - [ 00:50:36 INFO - "pgo_build", 00:50:36 INFO - "False", 00:50:36 INFO - "Change" 00:50:36 INFO - ] 00:50:36 INFO - ], 00:50:36 INFO - "revision": "e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b" 00:50:36 INFO - } 00:50:36 INFO - ], 00:50:36 INFO - "revision": "e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b" 00:50:36 INFO - } 00:50:36 INFO - } 00:50:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 00:50:36 INFO - Running post-action listener: _resource_record_post_action 00:50:36 INFO - ##### 00:50:36 INFO - ##### Running download-and-extract step. 00:50:36 INFO - ##### 00:50:36 INFO - Running pre-action listener: _resource_record_pre_action 00:50:36 INFO - Running main action method: download_and_extract 00:50:36 INFO - mkdir: /builds/slave/test/build/tests 00:50:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:36 INFO - https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 00:50:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/test_packages.json 00:50:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/test_packages.json 00:50:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 00:50:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 00:50:40 INFO - Downloaded 1302 bytes. 00:50:40 INFO - Reading from file /builds/slave/test/build/test_packages.json 00:50:40 INFO - Using the following test package requirements: 00:50:40 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:40 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 00:50:40 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'jsshell-linux-x86_64.zip'], 00:50:40 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 00:50:40 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:40 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 00:50:40 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 00:50:40 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 00:50:40 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 00:50:40 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 00:50:40 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 00:50:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 00:50:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:40 INFO - https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:50:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:42 INFO - Downloaded 21346027 bytes. 00:50:42 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 00:50:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:42 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 00:50:43 INFO - Return code: 0 00:50:43 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 00:50:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:43 INFO - https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 00:50:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:53 INFO - Downloaded 21346027 bytes. 00:50:53 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 00:50:53 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 00:50:53 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 00:50:54 INFO - Return code: 0 00:50:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:54 INFO - https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 00:50:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:50:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:50:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:55 INFO - Downloaded 11131717 bytes. 00:50:55 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 00:50:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 00:50:55 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 00:50:55 INFO - Return code: 0 00:50:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:55 INFO - https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 00:50:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:50:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:50:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/qi5EcGL3RviBLlPX8IXPGw/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 00:50:57 INFO - Downloaded 56848305 bytes. 00:50:57 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:50:57 INFO - mkdir: /builds/slave/test/properties 00:50:57 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 00:50:57 INFO - Writing to file /builds/slave/test/properties/build_url 00:50:57 INFO - Contents: 00:50:57 INFO - build_url:https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 00:50:57 INFO - Running post-action listener: _resource_record_post_action 00:50:57 INFO - Running post-action listener: set_extra_try_arguments 00:50:57 INFO - ##### 00:50:57 INFO - ##### Running populate-webroot step. 00:50:57 INFO - ##### 00:50:57 INFO - Running pre-action listener: _resource_record_pre_action 00:50:57 INFO - Running main action method: populate_webroot 00:50:57 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 00:50:57 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 00:50:57 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 00:50:57 INFO - '../fennec_ids.txt'], 00:50:57 INFO - 'tests': ['tcheck2']}, 00:50:57 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 00:50:57 INFO - '--tppagecycles', 00:50:57 INFO - '7'], 00:50:57 INFO - 'tests': ['tsvgm']}}, 00:50:57 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 00:50:57 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['tresize', 'tcanvasmark']}, 00:50:57 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:50:57 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 00:50:57 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:50:57 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 00:50:57 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'tests': ['damp', 'tps']}, 00:50:57 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['damp', 'tps']}, 00:50:57 INFO - 'g3': {'tests': ['dromaeo_dom']}, 00:50:57 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 00:50:57 INFO - 'other': {'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'other-e10s': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'other_l64': {'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'other_nol64': {'tests': ['a11yr', 00:50:57 INFO - 'ts_paint', 00:50:57 INFO - 'tpaint', 00:50:57 INFO - 'sessionrestore', 00:50:57 INFO - 'sessionrestore_no_auto_restore']}, 00:50:57 INFO - 'svgr': {'tests': ['tsvgx', 00:50:57 INFO - 'tsvgr_opacity', 00:50:57 INFO - 'tart', 00:50:57 INFO - 'tscrollx', 00:50:57 INFO - 'cart']}, 00:50:57 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['tsvgx', 00:50:57 INFO - 'tsvgr_opacity', 00:50:57 INFO - 'tart', 00:50:57 INFO - 'tscrollx', 00:50:57 INFO - 'cart']}, 00:50:57 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'tests': ['tp5o']}, 00:50:57 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'talos_options': ['--e10s'], 00:50:57 INFO - 'tests': ['tp5o']}, 00:50:57 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'talos_options': ['--xperf_path', 00:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:50:57 INFO - 'tests': ['tp5n']}, 00:50:57 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 00:50:57 INFO - 'talos_options': ['--e10s', 00:50:57 INFO - '--xperf_path', 00:50:57 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 00:50:57 INFO - 'tests': ['tp5n']}}, 00:50:57 INFO - 'talos.zip': {'path': '', 00:50:57 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 00:50:57 INFO - Running post-action listener: _resource_record_post_action 00:50:57 INFO - ##### 00:50:57 INFO - ##### Running create-virtualenv step. 00:50:57 INFO - ##### 00:50:57 INFO - Running pre-action listener: _resource_record_pre_action 00:50:57 INFO - Running main action method: create_virtualenv 00:50:57 INFO - Creating virtualenv /builds/slave/test/build/venv 00:50:57 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 00:50:57 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 00:50:57 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 00:50:57 INFO - Using real prefix '/usr' 00:50:57 INFO - New python executable in /builds/slave/test/build/venv/bin/python 00:50:57 INFO - Installing distribute.............................................................................................................................................................................................done. 00:50:59 INFO - Installing pip.................done. 00:50:59 INFO - Return code: 0 00:50:59 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 00:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:50:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:50:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:50:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:50:59 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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:50:59 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 00:50:59 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 00:50:59 INFO - Using env: {'DISPLAY': ':0', 00:50:59 INFO - 'HOME': '/home/cltbld', 00:50:59 INFO - 'LANG': 'en_US.UTF-8', 00:50:59 INFO - 'LANGUAGE': 'en_US:en', 00:50:59 INFO - 'LOGNAME': 'cltbld', 00:50:59 INFO - 'MAIL': '/var/mail/cltbld', 00:50:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:50:59 INFO - 'MOZ_NO_REMOTE': '1', 00:50:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:50:59 INFO - 'NO_EM_RESTART': '1', 00:50:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:50:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:50:59 INFO - 'PWD': '/builds/slave/test', 00:50:59 INFO - 'SHELL': '/bin/bash', 00:50:59 INFO - 'SHLVL': '1', 00:50:59 INFO - 'TERM': 'linux', 00:50:59 INFO - 'TMOUT': '86400', 00:50:59 INFO - 'USER': 'cltbld', 00:50:59 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:50:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:50:59 INFO - '_': '/tools/buildbot/bin/python'} 00:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:00 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 00:51:00 INFO - Cleaning up... 00:51:00 INFO - Return code: 0 00:51:00 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 00:51:00 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')]} 00:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:00 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')]} 00:51:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:00 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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:00 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 00:51:00 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 00:51:00 INFO - Using env: {'DISPLAY': ':0', 00:51:00 INFO - 'HOME': '/home/cltbld', 00:51:00 INFO - 'LANG': 'en_US.UTF-8', 00:51:00 INFO - 'LANGUAGE': 'en_US:en', 00:51:00 INFO - 'LOGNAME': 'cltbld', 00:51:00 INFO - 'MAIL': '/var/mail/cltbld', 00:51:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:00 INFO - 'MOZ_NO_REMOTE': '1', 00:51:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:00 INFO - 'NO_EM_RESTART': '1', 00:51:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:00 INFO - 'PWD': '/builds/slave/test', 00:51:00 INFO - 'SHELL': '/bin/bash', 00:51:00 INFO - 'SHLVL': '1', 00:51:00 INFO - 'TERM': 'linux', 00:51:00 INFO - 'TMOUT': '86400', 00:51:00 INFO - 'USER': 'cltbld', 00:51:00 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:00 INFO - '_': '/tools/buildbot/bin/python'} 00:51:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:00 INFO - Downloading/unpacking psutil>=0.7.1 00:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:02 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 00:51:02 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 00:51:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 00:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:02 INFO - Installing collected packages: psutil 00:51:02 INFO - Running setup.py install for psutil 00:51:02 INFO - building 'psutil._psutil_linux' extension 00:51:02 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 00:51:02 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 00:51:02 INFO - building 'psutil._psutil_posix' extension 00:51:02 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 00:51:02 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 00:51:02 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 00:51:02 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 00:51:02 INFO - Successfully installed psutil 00:51:02 INFO - Cleaning up... 00:51:02 INFO - Return code: 0 00:51:02 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 00:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:02 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:02 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 00:51:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 00:51:02 INFO - Using env: {'DISPLAY': ':0', 00:51:02 INFO - 'HOME': '/home/cltbld', 00:51:02 INFO - 'LANG': 'en_US.UTF-8', 00:51:02 INFO - 'LANGUAGE': 'en_US:en', 00:51:02 INFO - 'LOGNAME': 'cltbld', 00:51:02 INFO - 'MAIL': '/var/mail/cltbld', 00:51:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:02 INFO - 'MOZ_NO_REMOTE': '1', 00:51:02 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:02 INFO - 'NO_EM_RESTART': '1', 00:51:02 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:02 INFO - 'PWD': '/builds/slave/test', 00:51:02 INFO - 'SHELL': '/bin/bash', 00:51:02 INFO - 'SHLVL': '1', 00:51:02 INFO - 'TERM': 'linux', 00:51:02 INFO - 'TMOUT': '86400', 00:51:02 INFO - 'USER': 'cltbld', 00:51:02 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:02 INFO - '_': '/tools/buildbot/bin/python'} 00:51:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:02 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 00:51:02 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 00:51:02 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 00:51:02 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 00:51:02 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 00:51:02 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 00:51:02 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 00:51:04 INFO - Downloading mozsystemmonitor-0.0.tar.gz 00:51:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 00:51:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 00:51:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 00:51:04 INFO - Installing collected packages: mozsystemmonitor 00:51:04 INFO - Running setup.py install for mozsystemmonitor 00:51:05 INFO - Successfully installed mozsystemmonitor 00:51:05 INFO - Cleaning up... 00:51:05 INFO - Return code: 0 00:51:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 00:51:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 00:51:05 INFO - Using env: {'DISPLAY': ':0', 00:51:05 INFO - 'HOME': '/home/cltbld', 00:51:05 INFO - 'LANG': 'en_US.UTF-8', 00:51:05 INFO - 'LANGUAGE': 'en_US:en', 00:51:05 INFO - 'LOGNAME': 'cltbld', 00:51:05 INFO - 'MAIL': '/var/mail/cltbld', 00:51:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:05 INFO - 'MOZ_NO_REMOTE': '1', 00:51:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:05 INFO - 'NO_EM_RESTART': '1', 00:51:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:05 INFO - 'PWD': '/builds/slave/test', 00:51:05 INFO - 'SHELL': '/bin/bash', 00:51:05 INFO - 'SHLVL': '1', 00:51:05 INFO - 'TERM': 'linux', 00:51:05 INFO - 'TMOUT': '86400', 00:51:05 INFO - 'USER': 'cltbld', 00:51:05 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:05 INFO - '_': '/tools/buildbot/bin/python'} 00:51:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:05 INFO - Downloading/unpacking blobuploader==1.2.4 00:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:06 INFO - Downloading blobuploader-1.2.4.tar.gz 00:51:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 00:51:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 00:51:07 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 00:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 00:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 00:51:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 00:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 00:51:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 00:51:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 00:51:07 INFO - Downloading docopt-0.6.1.tar.gz 00:51:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 00:51:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 00:51:07 INFO - Installing collected packages: blobuploader, requests, docopt 00:51:07 INFO - Running setup.py install for blobuploader 00:51:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 00:51:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 00:51:07 INFO - Running setup.py install for requests 00:51:08 INFO - Running setup.py install for docopt 00:51:08 INFO - Successfully installed blobuploader requests docopt 00:51:08 INFO - Cleaning up... 00:51:08 INFO - Return code: 0 00:51:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:08 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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:08 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 00:51:08 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 00:51:08 INFO - Using env: {'DISPLAY': ':0', 00:51:08 INFO - 'HOME': '/home/cltbld', 00:51:08 INFO - 'LANG': 'en_US.UTF-8', 00:51:08 INFO - 'LANGUAGE': 'en_US:en', 00:51:08 INFO - 'LOGNAME': 'cltbld', 00:51:08 INFO - 'MAIL': '/var/mail/cltbld', 00:51:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:08 INFO - 'MOZ_NO_REMOTE': '1', 00:51:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:08 INFO - 'NO_EM_RESTART': '1', 00:51:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:08 INFO - 'PWD': '/builds/slave/test', 00:51:08 INFO - 'SHELL': '/bin/bash', 00:51:08 INFO - 'SHLVL': '1', 00:51:08 INFO - 'TERM': 'linux', 00:51:08 INFO - 'TMOUT': '86400', 00:51:08 INFO - 'USER': 'cltbld', 00:51:08 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:08 INFO - '_': '/tools/buildbot/bin/python'} 00:51:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:08 INFO - Running setup.py (path:/tmp/pip-iLaPp1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:08 INFO - Running setup.py (path:/tmp/pip-NyytHW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:08 INFO - Running setup.py (path:/tmp/pip-3CF9Q3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:51:08 INFO - Running setup.py (path:/tmp/pip-nyYuzE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:51:08 INFO - Running setup.py (path:/tmp/pip-KxWO_1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:51:08 INFO - Running setup.py (path:/tmp/pip-rvU1KX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:51:08 INFO - Running setup.py (path:/tmp/pip-xL6ecx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:51:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:51:08 INFO - Running setup.py (path:/tmp/pip-uhwzcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:51:09 INFO - Running setup.py (path:/tmp/pip-l0gEEs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:51:09 INFO - Running setup.py (path:/tmp/pip-GorqSx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:51:09 INFO - Running setup.py (path:/tmp/pip-zV4lcZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:51:09 INFO - Running setup.py (path:/tmp/pip-wKiBoE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:51:09 INFO - Running setup.py (path:/tmp/pip-719oqQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:51:09 INFO - Running setup.py (path:/tmp/pip-u9zx4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:09 INFO - Running setup.py (path:/tmp/pip-Sks2Pu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:51:09 INFO - Running setup.py (path:/tmp/pip-BXOaFf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:51:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:51:09 INFO - Running setup.py (path:/tmp/pip-PlKl6C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:51:09 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 00:51:09 INFO - Running setup.py install for manifestparser 00:51:09 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 00:51:09 INFO - Running setup.py install for mozcrash 00:51:09 INFO - Running setup.py install for mozdebug 00:51:09 INFO - Running setup.py install for mozdevice 00:51:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for mozfile 00:51:10 INFO - Running setup.py install for mozhttpd 00:51:10 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for mozinfo 00:51:10 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for mozInstall 00:51:10 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for mozleak 00:51:10 INFO - Running setup.py install for mozlog 00:51:10 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for moznetwork 00:51:10 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 00:51:10 INFO - Running setup.py install for mozprocess 00:51:10 INFO - Running setup.py install for mozprofile 00:51:11 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 00:51:11 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 00:51:11 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 00:51:11 INFO - Running setup.py install for mozrunner 00:51:11 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 00:51:11 INFO - Running setup.py install for mozscreenshot 00:51:11 INFO - Running setup.py install for moztest 00:51:11 INFO - Running setup.py install for mozversion 00:51:11 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 00:51:11 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 00:51:11 INFO - Cleaning up... 00:51:11 INFO - Return code: 0 00:51:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:11 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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:11 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 00:51:11 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 00:51:11 INFO - Using env: {'DISPLAY': ':0', 00:51:11 INFO - 'HOME': '/home/cltbld', 00:51:11 INFO - 'LANG': 'en_US.UTF-8', 00:51:11 INFO - 'LANGUAGE': 'en_US:en', 00:51:11 INFO - 'LOGNAME': 'cltbld', 00:51:11 INFO - 'MAIL': '/var/mail/cltbld', 00:51:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:11 INFO - 'MOZ_NO_REMOTE': '1', 00:51:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:11 INFO - 'NO_EM_RESTART': '1', 00:51:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:11 INFO - 'PWD': '/builds/slave/test', 00:51:11 INFO - 'SHELL': '/bin/bash', 00:51:11 INFO - 'SHLVL': '1', 00:51:11 INFO - 'TERM': 'linux', 00:51:11 INFO - 'TMOUT': '86400', 00:51:11 INFO - 'USER': 'cltbld', 00:51:11 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:11 INFO - '_': '/tools/buildbot/bin/python'} 00:51:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 00:51:11 INFO - Running setup.py (path:/tmp/pip-DHFzxV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 00:51:11 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)) 00:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 00:51:11 INFO - Running setup.py (path:/tmp/pip-WSnq38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 00:51:11 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)) 00:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 00:51:11 INFO - Running setup.py (path:/tmp/pip-VjDR5A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 00:51:11 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)) 00:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 00:51:11 INFO - Running setup.py (path:/tmp/pip-ZUwUVh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 00:51:11 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)) 00:51:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 00:51:11 INFO - Running setup.py (path:/tmp/pip-XoUn8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 00:51:12 INFO - Running setup.py (path:/tmp/pip-2gkGYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 00:51:12 INFO - Running setup.py (path:/tmp/pip-HVPyzi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 00:51:12 INFO - Running setup.py (path:/tmp/pip-lTkfIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 00:51:12 INFO - Running setup.py (path:/tmp/pip-Z5nsKW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 00:51:12 INFO - Running setup.py (path:/tmp/pip-13LZwB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 00:51:12 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 00:51:12 INFO - Running setup.py (path:/tmp/pip-8QCXIn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 00:51:12 INFO - Running setup.py (path:/tmp/pip-gdRb2F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 00:51:12 INFO - Running setup.py (path:/tmp/pip-l6SfXu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 00:51:12 INFO - Running setup.py (path:/tmp/pip-pir30C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:12 INFO - Running setup.py (path:/tmp/pip-FZNBxb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 00:51:12 INFO - Running setup.py (path:/tmp/pip-9MlzkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 00:51:12 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)) 00:51:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 00:51:12 INFO - Running setup.py (path:/tmp/pip-cNawAv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 00:51:12 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)) 00:51:12 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)) 00:51:12 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)) 00:51:12 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)) 00:51:12 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)) 00:51:12 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)) 00:51:12 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 00:51:12 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 00:51:12 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 00:51:12 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 00:51:12 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 00:51:12 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 00:51:12 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 00:51:14 INFO - Downloading blessings-1.5.1.tar.gz 00:51:14 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 00:51:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 00:51:14 INFO - Installing collected packages: blessings 00:51:14 INFO - Running setup.py install for blessings 00:51:14 INFO - Successfully installed blessings 00:51:14 INFO - Cleaning up... 00:51:14 INFO - Return code: 0 00:51:14 INFO - Done creating virtualenv /builds/slave/test/build/venv. 00:51:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:51:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:51:15 INFO - Reading from file tmpfile_stdout 00:51:15 INFO - Current package versions: 00:51:15 INFO - argparse == 1.2.1 00:51:15 INFO - blessings == 1.5.1 00:51:15 INFO - blobuploader == 1.2.4 00:51:15 INFO - docopt == 0.6.1 00:51:15 INFO - manifestparser == 1.1 00:51:15 INFO - mozInstall == 1.12 00:51:15 INFO - mozcrash == 0.16 00:51:15 INFO - mozdebug == 0.1 00:51:15 INFO - mozdevice == 0.47 00:51:15 INFO - mozfile == 1.2 00:51:15 INFO - mozhttpd == 0.7 00:51:15 INFO - mozinfo == 0.9 00:51:15 INFO - mozleak == 0.1 00:51:15 INFO - mozlog == 3.1 00:51:15 INFO - moznetwork == 0.27 00:51:15 INFO - mozprocess == 0.22 00:51:15 INFO - mozprofile == 0.27 00:51:15 INFO - mozrunner == 6.11 00:51:15 INFO - mozscreenshot == 0.1 00:51:15 INFO - mozsystemmonitor == 0.0 00:51:15 INFO - moztest == 0.7 00:51:15 INFO - mozversion == 1.4 00:51:15 INFO - psutil == 3.1.1 00:51:15 INFO - requests == 1.2.3 00:51:15 INFO - wsgiref == 0.1.2 00:51:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51:15 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/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 00:51:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/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 00:51:15 INFO - Using env: {'DISPLAY': ':0', 00:51:15 INFO - 'HOME': '/home/cltbld', 00:51:15 INFO - 'LANG': 'en_US.UTF-8', 00:51:15 INFO - 'LANGUAGE': 'en_US:en', 00:51:15 INFO - 'LOGNAME': 'cltbld', 00:51:15 INFO - 'MAIL': '/var/mail/cltbld', 00:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:15 INFO - 'MOZ_NO_REMOTE': '1', 00:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:15 INFO - 'NO_EM_RESTART': '1', 00:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:15 INFO - 'PWD': '/builds/slave/test', 00:51:15 INFO - 'SHELL': '/bin/bash', 00:51:15 INFO - 'SHLVL': '1', 00:51:15 INFO - 'TERM': 'linux', 00:51:15 INFO - 'TMOUT': '86400', 00:51:15 INFO - 'USER': 'cltbld', 00:51:15 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:15 INFO - '_': '/tools/buildbot/bin/python'} 00:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 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)) 00:51:15 INFO - Cleaning up... 00:51:15 INFO - Return code: 0 00:51:15 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 00:51: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')]} 00:51:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 00:51:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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')]} 00:51:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 00:51:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 00:51: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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1280030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13e28a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x14b1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'LANG': 'en_US.UTF-8', 'TERM': 'linux', 'SHELL': '/bin/bash', 'MOZ_NO_REMOTE': '1', 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', '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 00:51: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', 'jsonschema'] in /builds/slave/test/build 00:51: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 jsonschema 00:51:15 INFO - Using env: {'DISPLAY': ':0', 00:51:15 INFO - 'HOME': '/home/cltbld', 00:51:15 INFO - 'LANG': 'en_US.UTF-8', 00:51:15 INFO - 'LANGUAGE': 'en_US:en', 00:51:15 INFO - 'LOGNAME': 'cltbld', 00:51:15 INFO - 'MAIL': '/var/mail/cltbld', 00:51:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:15 INFO - 'MOZ_NO_REMOTE': '1', 00:51:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:15 INFO - 'NO_EM_RESTART': '1', 00:51:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:15 INFO - 'PWD': '/builds/slave/test', 00:51:15 INFO - 'SHELL': '/bin/bash', 00:51:15 INFO - 'SHLVL': '1', 00:51:15 INFO - 'TERM': 'linux', 00:51:15 INFO - 'TMOUT': '86400', 00:51:15 INFO - 'USER': 'cltbld', 00:51:15 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:15 INFO - '_': '/tools/buildbot/bin/python'} 00:51:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 00:51:15 INFO - Downloading/unpacking jsonschema 00:51:15 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 00:51:15 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 00:51:15 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 00:51:15 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 00:51:15 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 00:51:15 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 00:51:17 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 00:51:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fjsonschema-2.5.1-py2.py3-none-any.whl 00:51:17 INFO - Downloading/unpacking functools32 (from jsonschema) 00:51:17 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 00:51:17 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 00:51:17 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 00:51:17 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 00:51:17 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 00:51:17 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 00:51:17 INFO - Downloading functools32-3.2.3-2.tar.gz 00:51:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 00:51:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 00:51:17 INFO - warning: no files found matching '*.txt' 00:51:17 INFO - no previously-included directories found matching 'build' 00:51:17 INFO - no previously-included directories found matching 'dist' 00:51:17 INFO - no previously-included directories found matching '.git*' 00:51:17 INFO - Installing collected packages: jsonschema, functools32 00:51:17 INFO - Running setup.py install for functools32 00:51:17 INFO - warning: no files found matching '*.txt' 00:51:17 INFO - no previously-included directories found matching 'build' 00:51:17 INFO - no previously-included directories found matching 'dist' 00:51:17 INFO - no previously-included directories found matching '.git*' 00:51:17 INFO - Successfully installed jsonschema functools32 00:51:17 INFO - Cleaning up... 00:51:17 INFO - Return code: 0 00:51:17 INFO - Running post-action listener: _resource_record_post_action 00:51:17 INFO - Running post-action listener: _start_resource_monitoring 00:51:17 INFO - Starting resource monitoring. 00:51:17 INFO - ##### 00:51:17 INFO - ##### Running install step. 00:51:17 INFO - ##### 00:51:17 INFO - Running pre-action listener: _resource_record_pre_action 00:51:17 INFO - Running main action method: install 00:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 00:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 00:51:17 INFO - Reading from file tmpfile_stdout 00:51:17 INFO - Detecting whether we're running mozinstall >=1.0... 00:51:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 00:51:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 00:51:17 INFO - Reading from file tmpfile_stdout 00:51:17 INFO - Output received: 00:51:17 INFO - Usage: mozinstall [options] installer 00:51:17 INFO - Options: 00:51:17 INFO - -h, --help show this help message and exit 00:51:17 INFO - -d DEST, --destination=DEST 00:51:17 INFO - Directory to install application into. [default: 00:51:17 INFO - "/builds/slave/test"] 00:51:17 INFO - --app=APP Application being installed. [default: firefox] 00:51:17 INFO - mkdir: /builds/slave/test/build/application 00:51:17 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'] 00:51:17 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 00:51:32 INFO - Reading from file tmpfile_stdout 00:51:32 INFO - Output received: 00:51:32 INFO - /builds/slave/test/build/application/firefox/firefox 00:51:32 INFO - Running post-action listener: _resource_record_post_action 00:51:32 INFO - ##### 00:51:32 INFO - ##### Running run-tests step. 00:51:32 INFO - ##### 00:51:32 INFO - Running pre-action listener: _resource_record_pre_action 00:51:32 INFO - Running main action method: run_tests 00:51:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 00:51:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 00:51:32 INFO - Python 2.7.3 00:51:32 INFO - Return code: 0 00:51:32 INFO - grabbing minidump binary from tooltool 00:51:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 00:51:32 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 0x1543220>, '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 0x14af2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x14af740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 00:51:32 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 00:51:32 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 00:51:32 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 00:51:32 INFO - Return code: 0 00:51:32 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 00:51:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 00:51:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 00:51:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 00:51:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 00:51:32 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/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] in /builds/slave/test/build 00:51:32 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/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-055 --webServer localhost 00:51:32 INFO - Using env: {'DISPLAY': ':0', 00:51:32 INFO - 'HOME': '/home/cltbld', 00:51:32 INFO - 'LANG': 'en_US.UTF-8', 00:51:32 INFO - 'LANGUAGE': 'en_US:en', 00:51:32 INFO - 'LOGNAME': 'cltbld', 00:51:32 INFO - 'MAIL': '/var/mail/cltbld', 00:51:32 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 00:51:32 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 00:51:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 00:51:32 INFO - 'MOZ_NO_REMOTE': '1', 00:51:32 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 00:51:32 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 00:51:32 INFO - 'NO_EM_RESTART': '1', 00:51:32 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 00:51:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 00:51:32 INFO - 'PWD': '/builds/slave/test', 00:51:32 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 00:51:32 INFO - 'SHELL': '/bin/bash', 00:51:32 INFO - 'SHLVL': '1', 00:51:32 INFO - 'TERM': 'linux', 00:51:32 INFO - 'TMOUT': '86400', 00:51:32 INFO - 'USER': 'cltbld', 00:51:32 INFO - 'XDG_SESSION_COOKIE': '820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624', 00:51:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 00:51:32 INFO - '_': '/tools/buildbot/bin/python'} 00:51:32 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/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-055', '--webServer', 'localhost'] with output_timeout 3600 00:51:32 INFO - mozversion INFO | application_buildid: 20151124235532 00:51:32 INFO - mozversion INFO | application_changeset: e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b 00:51:32 INFO - mozversion INFO | application_display_name: Nightly 00:51:32 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 00:51:32 INFO - mozversion INFO | application_name: Firefox 00:51:32 INFO - mozversion INFO | application_remotingname: firefox 00:51:32 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 00:51:32 INFO - mozversion INFO | application_vendor: Mozilla 00:51:32 INFO - mozversion INFO | application_version: 45.0a1 00:51:32 INFO - mozversion INFO | platform_buildid: 20151124235532 00:51:32 INFO - mozversion INFO | platform_changeset: e799e37d4bd2c07f8a3be5bad6fbce060d7adc9b 00:51:32 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 00:51:32 INFO - mozversion INFO | platform_version: 45.0a1 00:51:32 INFO - 2015-11-25 00:51:32,541 DEBUG : using testdate: 1448441492 00:51:32 INFO - 2015-11-25 00:51:32,541 DEBUG : actual date: 1448441492 00:51:32 INFO - 2015-11-25 00:51:32,549 INFO : starting webserver on 'localhost:41223' 00:51:32 INFO - 2015-11-25 00:51:32,550 INFO : Starting test suite talos-linux64-ix-055 00:51:32 INFO - 2015-11-25 00:51:32,550 INFO : Starting test dromaeo_css 00:51:32 INFO - 2015-11-25 00:51:32,550 DEBUG : operating with platform_type : linux_ 00:51:32 INFO - 2015-11-25 00:51:32,551 INFO : Initialising browser for dromaeo_css test... 00:51:32 INFO - 2015-11-25 00:51:32,567 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdKwOj/profile http://localhost:41223/getInfo.html 00:51:36 INFO - 2015-11-25 00:51:36,507 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 00:51:36 INFO - 2015-11-25 00:51:36,507 DEBUG : BROWSER_OUTPUT: colorDepth:24 00:51:36 INFO - 2015-11-25 00:51:36,507 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 00:51:36 INFO - 2015-11-25 00:51:36,507 DEBUG : BROWSER_OUTPUT: __metrics 00:51:36 INFO - 2015-11-25 00:51:36,595 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 00:51:37 INFO - 2015-11-25 00:51:37,887 INFO : Browser initialized. 00:51:37 INFO - 2015-11-25 00:51:37,887 INFO : Running cycle 1/1 for dromaeo_css test... 00:51:37 INFO - 2015-11-25 00:51:37,887 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpSdKwOj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 00:51:49 INFO - 2015-11-25 00:51:49,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 139665408 00:51:49 INFO - 2015-11-25 00:51:49,713 DEBUG : BROWSER_OUTPUT: 00:52:40 INFO - 2015-11-25 00:52:40,865 DEBUG : BROWSER_OUTPUT: 1448441560864 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] 00:54:52 INFO - 2015-11-25 00:54:52,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41223/tests/dromaeo/cssquery-ext.html) 00:54:53 INFO - 2015-11-25 00:54:53,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 251269120 00:54:53 INFO - 2015-11-25 00:54:53,652 DEBUG : BROWSER_OUTPUT: 00:57:56 INFO - 2015-11-25 00:57:56,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-ext.html (next: http://localhost:41223/tests/dromaeo/cssquery-jquery.html) 00:57:56 INFO - 2015-11-25 00:57:56,850 DEBUG : BROWSER_OUTPUT: RSS: Main: 219680768 00:57:56 INFO - 2015-11-25 00:57:56,851 DEBUG : BROWSER_OUTPUT: 01:00:58 INFO - 2015-11-25 01:00:58,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41223/tests/dromaeo/cssquery-mootools.html) 01:00:59 INFO - 2015-11-25 01:00:59,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 214761472 01:00:59 INFO - 2015-11-25 01:00:59,487 DEBUG : BROWSER_OUTPUT: 01:04:01 INFO - 2015-11-25 01:04:01,415 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41223/tests/dromaeo/cssquery-prototype.html) 01:04:02 INFO - 2015-11-25 01:04:02,008 DEBUG : BROWSER_OUTPUT: RSS: Main: 203476992 01:04:02 INFO - 2015-11-25 01:04:02,008 DEBUG : BROWSER_OUTPUT: 01:07:04 INFO - 2015-11-25 01:07:04,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41223/tests/dromaeo/cssquery-yui.html) 01:07:05 INFO - 2015-11-25 01:07:05,375 DEBUG : BROWSER_OUTPUT: RSS: Main: 208089088 01:07:05 INFO - 2015-11-25 01:07:05,375 DEBUG : BROWSER_OUTPUT: 01:10:07 INFO - 2015-11-25 01:10:07,936 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/dromaeo/cssquery-yui.html (next: http://localhost:41223/tests/dromaeo/cssquery-dojo.html) 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: RSS: Main: 252063744 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:10:08 INFO - 2015-11-25 01:10:08,187 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:10:08 INFO - 2015-11-25 01:10:08,189 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2612.7126016138222;2710.2140379289995;2725.1824452664196;2735.206790030891;2735.617013618093;4392.209402307583;4478.305862591295;4520;4571.131485017849;4595.356650068993;4475.820967161318;4508.323751437278;4575.542445755423;4589.105124500724;4629.884252893679;4178.206140833247;4212.747235165884;4215.768132752697;4272.893177670568;4286.078493123978;4073.103917138225;4258.659307255428;4291.570842915699;4308.46144231971;4346.087321662455;4111.198316328332;4143.440635514197;4209.494860616715;4213.115245798386;4237.237297286487;4217.030083080878;4221.345691417835;4238.067625122468;4265.466816647919;4282.8715138545895;4022.9597704022876;4123.092919557693;4202.768847713374;4220.240356735786;4252.87241382759;4453.51011388747;4463.665225108098;4517.503074661785;4531.8187272509385;4558.954410455886;4856.101621200054;4858.854234372974;4860.8055677772845;4862.635302352338;4902.803887844482;4701.78841952113;4841.878953026167;4889.951100489021;4894.975525122351;4920.6801557898625;4429.202743506167;4540.9772951135365;4575.336576196433;4593.839215627437;4629.629629629621;4950.4059512858685;4973.378327709036;4976.8755781105765;5014.724190169576;5015.573676237488;4630.536946305342;4746.359241502422;4748.572628463455;4763.595094417014;4800.423949126127;4761.35721677576;4790.4251489821445;4824.662273640812;4852.805887764521;4891.877703057452;4813.638977076734;4814.687045342112;4817.710937343771;4858.78135483904;4880.877978050577;4619.3994780678295;4727.078219747185;4807.567318941312;4823.2282834746275;4845.466998630148;4016.116454380032;4038.8586399475876;4066.054679704662;4085.9182816343505;4117.608827161415;3545.468179773003;3547.219611685425;3573.4282514797505;3579.534660494119;3586.8206589670413;4062.5937406259727;4167.5832416758085;4261.97869010653;4266.637335826427;4267.25323068468;4791.281307803857;4844.806207751651;4910.803567857246;4945.455999840086;4957.454679985199;4197.5172855122055;4202.159568086395;4211.410402543646;4220.008298049956;4253.255680255943;4298.699091063596;4302.204092242945;4322.805473753689;4346.739195648208;4379.1241751649795;4424.446944131983;4544.590986811269;4547.363369128391;4629.67592268538;4830.227163653799;4909.926351104665;4927.531884470969;4929.408470983505;4936.533844456774;4975.253711943093;4707.552782485658;4710.1757192490495;4714.387129673258;4717.457492388282;4758.88102797419;4606.6314694825005;4713.128071306819;4714.457837348612;4800.591949684176;4919.3604831371695;4882.804687812448;4888;4893.877653058702;4898.8402480400655;4931.408231012158;4739.099571081483;4740.2178640523925;4746.762661866824;4747.311639812277;4786.1624215762795;4537.274036154199;4640.559146881041;4652.813887444464;4712.151812673752;4824.372831531879;4628.884277893079;4658.557437043475;4658.557437043475;4675.462321833033;4695.788689509049;4759.714417134983;4777.665563410667;4778.307145463958;4817.13291607514;4820.204666230033;4565.292379681155;4638.095571363552;4679.087577922409;4684.180268453075;4713.2458806590785 01:10:08 INFO - 2015-11-25 01:10:08,190 DEBUG : BROWSER_OUTPUT: |1;ext.html;575.1717526761463;575.1975993489083;575.6977586766947;578.69040063566;581.9272590926134;28331;28903.277418064532;34376.82811585942;34443.827780861124;34590.8270458648;38842.417363739565;39482.210355792864;39499.802500987455;39522.604773952255;39561.802190989;6960.930390696104;7946.404019698517;8113.594320283992;8113.8782918256275;8114.391420643446;6998.68505917235;10183.745406364864;10370.896291037106;10471.267011309212;10494.790104197911;10083.798324033514;10138.645147419842;10163;10173.694789156338;10182.338148020392;7178.928210717878;7346.632668366614;9916.157126644244;9976.002399760002;10185.439800810953;9903.108720215143;10078.79842403155;10090.990900909923;10110.19118470528;10123.746906327327;37725.43411848824;38020.61979380198;38103.23793524114;38207.23585528302;38520.22959540794;2780.3605170810624;2811.395549956769;2847.2170153207826;2853.6004959305715;3497.7901325920525;27785.722142778515;28062.85968570144;28086.719132808616;28424.71575284262;28467.28831779222;3440.6043305019743;3505.526753888218;3527.8236088195745;3577.2487777566744;3638.8362523686233;221110;222889.99999999837;223434;223659.99999999837;223980;51337.48662513402;55778.72110639421;55862;55997.72001139968;56195;49717;60574;61916.07125893115;61953;62053;13025.283609401575;13241.205527668371;13241.73516529664;13253.602391928258;13258.270795106362;9564;9578.329516933887;9586.760330991781;9589.328746987783;9589.952050239845;19237.903810480857;19345.806541934682;19457.61084778325;19466.70799938002;19481.73368731028;7454.85090298191;7790.805229869298;7800.453968222283;7814.335781458526;7998.4001199910235;836.460482988469;859.9183077607618;890.8396488631979;951.6811868024289;983.3952119446488;27098.86450567774;27136.457270854473;27564;27580.724192757814;27592.862035689694;947.9526023698926;960.8222478841436;988.8430536272579;1007.652359935821;1070.7055559720984;13819;14051.367688454044;15467.767983480257;16483.752743708854;16501.257443415074;329460;334614;335159;335218;336028;50151.498485015414;50689.23966140511;50764.74617626962;50778.41437441878;50782;1219.0856857356982;1219.5609580550995;1236.3323805145121;1239.3926975781983;1239.9876001240052;27815.860920695268;28635.140945770825;28810.991615293366;28967.275818104717;29213.561796573493;36410.27179456343;37187.81406092952;43240.135197296506;43606.56393436025;44256.557434425245;199071;199811;201389;201542;201559;36102;36654.81672591727;36657;36672.63327366692;36689.26621467502;42352.5764742361;42565;42664.14671706486;42861.78569107259;43033;36173.457398138526;36627.45058824173;37008.259834802615;37058;37502.62497375101;36318.636813632584;36608.45087323745;37779.62220377871;39179.41230881596;39683;34937.30125397427;35133.121671958404;35189.47215791714;35200.471992919614;38435.6156438432;28962.710372896003;30473.390532188787;31251.37497250088;31277;31379.215519612193;23970.40073998164;24376.390590235387;24492.87753561221;24507.50984980326;24587.262382128563 01:10:08 INFO - 2015-11-25 01:10:08,194 DEBUG : BROWSER_OUTPUT: |2;jquery.html;341.6941837055835;342.1565840203897;343.22088858291676;343.3390722858497;344.89997900608824;12228.93885530571;12572.559960401388;15224.162671053102;15324.923375383121;15979.961302515343;12629.179103358276;14616.342264598092;15084.773728394082;15547.92226038871;15552.922235388836;4715.151272770909;4887.218045112782;5013.498650134994;5162.793488260465;5176.7411629418375;3351.715104216132;3495.5281037059926;5070.974645126769;5093.414257360396;5102.387713474388;5113.386393632769;5226.503482169207;5244;5245.973770131144;5248.107821670325;5178.40448348441;5215.322008138936;5215.765290561933;5219.739013049351;5358.91961620576;5219.451957544441;5225.111731005738;5227.398849132361;5242.764075616568;5245.763940622643;18145;18210.63578728431;18266.543336416562;18669.973151476664;18703.43889683298;1668.3243286468999;1842;1866.178881292227;1883.5385330594092;1950.3466338776527;8905.599248033854;8974.102589741038;9039.186473217442;9173.58718857653;9252.444853308823;1759.8050187768933;1767.460924418052;1785.8482029027548;1787.6692811829723;1822.298415110179;53219.73390133025;56099.71950140223;57307.426925731044;57480.42519574834;57912.71043644797;10010.349327293703;10019.549120289605;10028.097471227624;10056.949715251378;10069.848952265722;12730.68173295675;12731.10882238253;12734.108612397229;12751.61745147647;12755.93622031884;6744;7012.789616311519;7017.789466316019;7077.3984211341585;7133.286671332929;6344.524160687967;6440.388163124496;6536.869262614721;6678.365555272241;6740.022696708949;4192.7065105442325;4212;4217.219814334358;4243.8090285937205;4256.936145957751;1591.816941051794;1643.047032721019;1719.2263481433406;1761.0842361971959;1789.8210178981997;386.12735218406044;387.60270722509654;842.6839935024366;883.4037025008093;965.7633879699519;9654.324197306121;10116.393016419039;14931.477398291008;15799.842001579837;15899.841001590068;723.989140162898;803.477739469338;858.7295002074327;866.3978534918172;866.5580553917422;8634.913650863411;8861.025287218401;8942.86585701215;8978.595963181673;8985.371024028385;338467;339921;340267;341114;346329;60751.69624151939;60804.69597651983;60892.69553652292;61285.38714612886;63809.68095159494;1040.7138037039874;1068.770214403907;1070.053003092269;1081.6376513867942;1082.3235477826358;13562.525311614047;14251.786223206867;14264.429422823387;14307.64230894236;14497.565073047825;28330.716692833634;28912.855435722686;32725;33441.163970900925;34102;42655.57344426516;42811.57188428076;44505.55494445014;44516.109677805616;44524.332135018645;13208.603741887759;13294.401751920994;13635.318234088454;13661.863381366456;13754.381052852446;17586.20862061236;17668;17961.640767184843;18186.636267274316;18403.815961840744;2385.85684858909;10747.677569672922;14363.56909292723;14424.8460123192;14799.408023678932;14124.223167725873;14165.15009099416;14555.41778328855;14651.94872717799;15010.624734381729;14137.36381862798;14182.645433864236;14188.574342769733;14972.176530290502;15261.23693815327;13439.865601344252;13575.660608484866;13590.59228223155;13715.657108572366;13725;14228.430862765374;14583.125012499284;14630.926845365704;14678.633034173803;14822.110673359633 01:10:08 INFO - 2015-11-25 01:10:08,194 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1407.7254935287624;1586.7540531217662;1635.4112519492987;1649.645326254855;1673.121611154144;5804.593678442506;6088.878222435548;6836.316368363167;7068.187158476777;7129.89305160423;7094.432445404368;7118.466115041379;7162.1763497197835;7171.9641401792915;7207.42340612751;1743.43338415015;1778.510909499885;2044.4582185720797;2077.27295446594;2079.480129967508;2079.7504299484085;2113.080809847721;2119.247667078188;2121.427214652043;2122.4269447249235;2010.8491863110253;2046.6827641715558;2048.5902819436096;2051.507638166837;2053.9589208215825;2060.1965233558926;2080.8959552022416;2107.2835236019673;2109.3461027081653;2111.873287602741;2042.3260324093014;2065.1945741160957;2066.8966551672506;2069.7619773726065;2070.8343332533514;6932.514723969324;6939.23668396476;6973.267806880306;6985.161780586312;7021.719131234744;4031.7580945143386;4131.421600975866;4136.772477513736;4147.771872547009;4170.52039015511;2666.4533770576986;2722.0472834507964;2736.9589456158174;2741.972580274192;2753.2703833484143;706.2584286499207;829.6266679994027;842.4397775479299;846.5936350551708;847.7838151271447;8731.388802783807;8734.825303493959;8743.475391476468;8793.648254069829;8851.690190843354;3904.590018048064;3968.57131432684;3975.483187185705;3985.740926839804;3992.2215168042535;8021.679132834622;8045.034595848536;8047.315978141806;8047.476914000571;8047.51714897108;4184.016756062323;4191.371294305878;4194.30793919006;4196.790160491963;4199.832006719758;3811.8284677189595;3817.7327587069194;3828.655421012122;3840.1935593525673;3843.557990831034;3372.6795954384293;3404;3416.265502916885;3422.486627005919;3457.291255292659;1077.8868218837067;1078.0351585331084;1083.3987137138963;1086.9673909782719;1087.635642059903;976.3604838830578;989.351974456732;1003.4430890855499;1003.8092762375126;1004.0110491166196;6264.1856558648;6353.96823015882;6356.3961423665605;6368.39500247485;6376.808695739135;429.5747210261818;430.2384778941319;431.20873197681976;435.6667149630535;437.5908525528641;4994.850154495371;5053.418856831438;5054.064997975386;5067.771950262247;5070.467600901852;6972.825679358057;7223.566586004751;8195.71315003984;8258.504489730636;8451.830963380698;7559.886601700979;7698;7839.764807055797;7840.059192896889;7847.607619619111;6163.075538669235;6307.337729538424;6318.083877837687;6318.210223722035;6324.1146239527425;6259.687015649109;6398.360163983564;6399;6410.519211059096;6412.198475190601;7266.636668166676;7350.3384695375535;7387.963060184665;7410.96294518524;7460.776176714708;7298.6715597797165;7505.66224519887;7522.849543009219;7544.0192774938905;7603.7338693145475;6126.23422072241;6197.225346831646;6210.720517576629;6226.5641405101205;6243.719032643451;5789.218455508452;5962.791302304398;6559.14731084975;6575.408213260829;6627.768028118992;6124.14262003311;6149.938500614937;6163.3836616338;6210.130581718473;6221.2845522765465;6014.8195554133445;6045.78839740607;6060.181875446759;6157.076438534255;6261.123442717932;6214.161088253209;6229.096780966644;6235.532335074979;6248.750049997949;6257.874842503215;5504.669719816824;5607.915881261866;5608.6073974821375;5653.293338332708;5666.15007748841;5768.7404066817935;5769.221155144001;5772.451617096369;5784.739686714024;5805.187273781589 01:10:08 INFO - 2015-11-25 01:10:08,195 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.1055714819893;311.8020057263637;317.4682406968329;319.60369142263585;323.05506393798134;5099.668521546097;5141.126008578542;5274.367075950881;5326.600504962129;5354.518093371596;5038.571721403685;5179.482051794818;5200.4019537753165;5215.217717342391;5217.973910130444;3884.9028774280728;3972.7020473464463;4110.342345224764;4110.794460276989;4119.258533463975;3977.602239776028;4088.8364465421346;4100.712950093494;4110.547839737626;4118.691098167635;4063.3701776224584;4063.6952228582827;4069;4071.084006098634;4076.694247931402;4059.8579049733266;4066.552679205285;4071.653909417703;4072.552019277877;4079.714419990602;3579.588347340063;3581;3581.7492775505725;3590.335787879251;3591.94612080819;4938.827141050046;5058.418281897592;5063.1898896176435;5068.645194836363;5071.594272458195;4668.719876807402;4668.929966050512;4671.229247174212;4673.252279635242;4676.438827340707;5254.15933450646;5482.643628164156;5497.065498865202;5499.50504454601;5513.228148059275;3751.9624803751885;3782.2813665403487;3875.961240387588;3880.708946828971;3884.9223015539533;5778.075507918713;5839.591228614041;5843.065109582489;5859.121131830217;5885.646861188342;3981.6814654827544;3982.3628219484744;3983.960160398417;3984.382420724792;3984.8406063757707;4043.393490976377;4047.3321901886447;4049.6962727795535;4052;4056.1076563156057;4480.910381792346;4581.266997280486;4615;4653.604443622262;4658.604018658384;5553.111502159635;5554.861128471821;5560.193771903132;5562.721863906789;5567.55459563242;1411.7529432349297;1435.4617018618019;1435.806166167575;1437.5112461763051;1439.4242303078643;967.2697113679127;970.3110791338088;974.4250891973769;995.4723996281982;997.1175509673845;4909.26361045846;4912.70523768575;4921.163402221631;4921.483244259372;4925.285833554115;5740.368559458456;5747.3677895431465;5750.597458177887;5762.135679648002;5772.624779389326;4910.705357678551;4923.384576927884;4925.556699897026;4927.137750893651;4927.827526036572;3006.4888968875343;3069.524223745323;3098.5042393216977;3100.472919603673;3101.937961240808;5503.422140675251;5559.33288005442;5565.777368905279;5567.944320556742;5570.470805273492;5953.493953014043;5954.136650185699;5962.493188078975;5969.641821490724;5975.790847320323;5503.587230957694;5515.338159420895;5537.5569954404355;5539.806106786324;5541.556675465953;5641.746121424628;5767.5385969121535;5770.942290577041;5782.942170578241;5786.247787787561;5401.189821526802;5536.114221724666;5567.3040869891265;5643.717814109196;5668.376478587435;5490.450954904478;5526.281583394133;5526.668399896019;5528.115501519898;5540.085885828793;3965.1673148637956;3998.9602703297933;4007.8196481157834;4008.1783234437453;4009.0979529605606;5602;5698.2592263005545;5757.798477053283;5759.424057594207;5771.538276937751;5557.638753481011;5571.331440227199;5573.024720673785;5575.1915972184615;5576.972115139561;5564.387917329172;5567.916481252703;5568.638038527482;5576.888462230651;5581.10702287632;5455;5461.371942226695;5470.206820011155;5471.452854714496;5474.151506516497;5409.702466364388;5596.18855265976;5610.943890561205;5613.550915926798;5623.3814280428305;5467.4532546745;5485.561155107662;5487.067198576172;5488.670679759227;5492.890142197213 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: |5;yui.html;640.2445114764579;677.6408503493147;723.4140346319485;752.180123665205;764.3083009876062;11060.170487213461;11184.32894026359;11198.272112312694;11203.831942520848;11258.099352051837;11746.119041071932;11852.703682407944;12427.68930776731;12573.11988160829;12588.622341329774;613.0161091448206;762.9351505122057;773.6673230510878;774.44240147094;774.6281784743327;612.5038718637918;751.77070993347;769.5998080997878;770.5646309834925;771.7993321736361;797.2266901105918;809.3686924199134;809.9595020248994;810.222186700768;810.3962547901822;639.2744235292953;645.9547831651786;777.0869228656306;799.8400319936007;802.1176705623797;587.3803137689736;588.0268156201494;588.0796553393925;588.5556404914305;589.0281036290113;11044.558217671283;11129.885321788915;11181.664550063511;11182.16133789969;11198.888011119947;9641.27690423221;11387;11406.543738250542;11407.31556106628;11611.825822612667;9517.714468565884;9544.61821527145;9596.616135354578;9679.564419601065;9689;3174.4444722173525;3227.209333713232;3309.6855798699085;3320.750943679234;3326.284848757529;42871.57128428707;43944.78027609905;43979;44651.77674111641;44691.32963005525;8859.822803543893;8875.068117847663;9022.458652480873;9078.54607269634;9174.311926605531;16173.59566010859;16407.261673224733;16428.260728267258;16439.506814795575;16478.09370484611;6464.062710906892;6471.935280647133;6563.146790917151;6618.7352505899225;6770.45836333102;3681.4109742441083;3701.2227432239533;3712.7215458840697;3718.6839118674675;3740.532433445819;2764.7926405519665;2795.147480018614;2798.9300267493477;2802.1873656639345;2803.509385857467;487.74637188662405;491.68532139430795;493.7777999900059;493.9110960027158;499.4406264983242;445.6657506869848;454.8749093999111;560.1933216168785;580.506569415993;589.0545674192858;7223.349898509055;7402.407807375397;7410.888836667455;7684.577348245788;7824.726134585262;391.91965647042286;488.5236894028294;516.860447679132;552.6269767906647;591.6331874237914;3360.479125735515;3383.932321353559;3626.6917312028772;3640.5449318835144;3661.212839239576;51854.74072629613;52650;52793.472065279624;52834.47165528373;53011.20483192755;45767.084658306645;46547;46579.30131048037;46611;46613.533864660916;42533.57466425358;43736.56263437325;43903.926725128935;44513.33230001553;44607.77696111563;7270.709171633075;7274;7282.526635768658;7436.851262974818;7466;29836.552451712807;30225.697743022287;30883;32535.698572057798;32870.506942396365;38692.22615547617;39841.2031759369;40545;40612.59387406088;40814.387784183855;9468.337216394786;9544.379615324982;9562.139407453084;9593.856092158763;9702.5148742564;10476.423796691255;10523.473826308807;10525.36847789135;10581.735456613646;10959.726006849893;10124.08883200486;10323.535440905027;10362.792744145225;10376.948115259678;10579.206559508222;9994.250431217833;10102.949485252526;10119;10359.950105926066;10421.791564168523;8550.228367236195;8622.310215182895;8673.956630216808;8883.911160888567;10234.692959211236;7823.8435231293915;8512.829743405222;8608.397412181088;8685.218330350299;8808;6963.442924565921;7788.454808163374;7958.363330933627;8038.598070096355;8278.875816862632 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,945 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: __startTimestamp1448442608185__endTimestamp 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,197 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: Number of tests: 6 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4499.70 Median:4629.68 stddev:452.07 (9.8%) stddev-sans-first:428.53 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: Values: 2612.7 2710.2 2725.2 2735.2 2735.6 4392.2 4478.3 4520.0 4571.1 4595.4 4475.8 4508.3 4575.5 4589.1 4629.9 4178.2 4212.7 4215.8 4272.9 4286.1 4073.1 4258.7 4291.6 4308.5 4346.1 4111.2 4143.4 4209.5 4213.1 4237.2 4217.0 4221.3 4238.1 4265.5 4282.9 4023.0 4123.1 4202.8 4220.2 4252.9 4453.5 4463.7 4517.5 4531.8 4559.0 4856.1 4858.9 4860.8 4862.6 4902.8 4701.8 4841.9 4890.0 4895.0 4920.7 4429.2 4541.0 4575.3 4593.8 4629.6 4950.4 4973.4 4976.9 5014.7 5015.6 4630.5 4746.4 4748.6 4763.6 4800.4 4761.4 4790.4 4824.7 4852.8 4891.9 4813.6 4814.7 4817.7 4858.8 4880.9 4619.4 4727.1 4807.6 4823.2 4845.5 4016.1 4038.9 4066.1 4085.9 4117.6 3545.5 3547.2 3573.4 3579.5 3586.8 4062.6 4167.6 4262.0 4266.6 4267.3 4791.3 4844.8 4910.8 4945.5 4957.5 4197.5 4202.2 4211.4 4220.0 4253.3 4298.7 4302.2 4322.8 4346.7 4379.1 4424.4 4544.6 4547.4 4629.7 4830.2 4909.9 4927.5 4929.4 4936.5 4975.3 4707.6 4710.2 4714.4 4717.5 4758.9 4606.6 4713.1 4714.5 4800.6 4919.4 4882.8 4888.0 4893.9 4898.8 4931.4 4739.1 4740.2 4746.8 4747.3 4786.2 4537.3 4640.6 4652.8 4712.2 4824.4 4628.9 4658.6 4658.6 4675.5 4695.8 4759.7 4777.7 4778.3 4817.1 4820.2 4565.3 4638.1 4679.1 4684.2 4713.2 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:42346.98 Median:35194.97 stddev:67783.34 (192.6%) stddev-sans-first:67900.92 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: Values: 575.2 575.2 575.7 578.7 581.9 28331.0 28903.3 34376.8 34443.8 34590.8 38842.4 39482.2 39499.8 39522.6 39561.8 6960.9 7946.4 8113.6 8113.9 8114.4 6998.7 10183.7 10370.9 10471.3 10494.8 10083.8 10138.6 10163.0 10173.7 10182.3 7178.9 7346.6 9916.2 9976.0 10185.4 9903.1 10078.8 10091.0 10110.2 10123.7 37725.4 38020.6 38103.2 38207.2 38520.2 2780.4 2811.4 2847.2 2853.6 3497.8 27785.7 28062.9 28086.7 28424.7 28467.3 3440.6 3505.5 3527.8 3577.2 3638.8 221110.0 222890.0 223434.0 223660.0 223980.0 51337.5 55778.7 55862.0 55997.7 56195.0 49717.0 60574.0 61916.1 61953.0 62053.0 13025.3 13241.2 13241.7 13253.6 13258.3 9564.0 9578.3 9586.8 9589.3 9590.0 19237.9 19345.8 19457.6 19466.7 19481.7 7454.9 7790.8 7800.5 7814.3 7998.4 836.5 859.9 890.8 951.7 983.4 27098.9 27136.5 27564.0 27580.7 27592.9 948.0 960.8 988.8 1007.7 1070.7 13819.0 14051.4 15467.8 16483.8 16501.3 329460.0 334614.0 335159.0 335218.0 336028.0 50151.5 50689.2 50764.7 50778.4 50782.0 1219.1 1219.6 1236.3 1239.4 1240.0 27815.9 28635.1 28811.0 28967.3 29213.6 36410.3 37187.8 43240.1 43606.6 44256.6 199071.0 199811.0 201389.0 201542.0 201559.0 36102.0 36654.8 36657.0 36672.6 36689.3 42352.6 42565.0 42664.1 42861.8 43033.0 36173.5 36627.5 37008.3 37058.0 37502.6 36318.6 36608.5 37779.6 39179.4 39683.0 34937.3 35133.1 35189.5 35200.5 38435.6 28962.7 30473.4 31251.4 31277.0 31379.2 23970.4 24376.4 24492.9 24507.5 24587.3 01:10:08 INFO - 2015-11-25 01:10:08,198 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,199 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:22254.52 Median:30818.93 stddev:55880.83 (181.3%) stddev-sans-first:56013.37 01:10:08 INFO - 2015-11-25 01:10:08,199 DEBUG : BROWSER_OUTPUT: Values: 341.7 342.2 343.2 343.3 344.9 12228.9 12572.6 15224.2 15324.9 15980.0 12629.2 14616.3 15084.8 15547.9 15552.9 4715.2 4887.2 5013.5 5162.8 5176.7 3351.7 3495.5 5071.0 5093.4 5102.4 5113.4 5226.5 5244.0 5246.0 5248.1 5178.4 5215.3 5215.8 5219.7 5358.9 5219.5 5225.1 5227.4 5242.8 5245.8 18145.0 18210.6 18266.5 18670.0 18703.4 1668.3 1842.0 1866.2 1883.5 1950.3 8905.6 8974.1 9039.2 9173.6 9252.4 1759.8 1767.5 1785.8 1787.7 1822.3 53219.7 56099.7 57307.4 57480.4 57912.7 10010.3 10019.5 10028.1 10056.9 10069.8 12730.7 12731.1 12734.1 12751.6 12755.9 6744.0 7012.8 7017.8 7077.4 7133.3 6344.5 6440.4 6536.9 6678.4 6740.0 4192.7 4212.0 4217.2 4243.8 4256.9 1591.8 1643.0 1719.2 1761.1 1789.8 386.1 387.6 842.7 883.4 965.8 9654.3 10116.4 14931.5 15799.8 15899.8 724.0 803.5 858.7 866.4 866.6 8634.9 8861.0 8942.9 8978.6 8985.4 338467.0 339921.0 340267.0 341114.0 346329.0 60751.7 60804.7 60892.7 61285.4 63809.7 1040.7 1068.8 1070.1 1081.6 1082.3 13562.5 14251.8 14264.4 14307.6 14497.6 28330.7 28912.9 32725.0 33441.2 34102.0 42655.6 42811.6 44505.6 44516.1 44524.3 13208.6 13294.4 13635.3 13661.9 13754.4 17586.2 17668.0 17961.6 18186.6 18403.8 2385.9 10747.7 14363.6 14424.8 14799.4 14124.2 14165.2 14555.4 14651.9 15010.6 14137.4 14182.6 14188.6 14972.2 15261.2 13439.9 13575.7 13590.6 13715.7 13725.0 14228.4 14583.1 14630.9 14678.6 14822.1 01:10:08 INFO - 2015-11-25 01:10:08,199 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,199 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4773.69 Median:5988.81 stddev:2427.71 (40.5%) stddev-sans-first:2421.34 01:10:08 INFO - 2015-11-25 01:10:08,200 DEBUG : BROWSER_OUTPUT: Values: 1407.7 1586.8 1635.4 1649.6 1673.1 5804.6 6088.9 6836.3 7068.2 7129.9 7094.4 7118.5 7162.2 7172.0 7207.4 1743.4 1778.5 2044.5 2077.3 2079.5 2079.8 2113.1 2119.2 2121.4 2122.4 2010.8 2046.7 2048.6 2051.5 2054.0 2060.2 2080.9 2107.3 2109.3 2111.9 2042.3 2065.2 2066.9 2069.8 2070.8 6932.5 6939.2 6973.3 6985.2 7021.7 4031.8 4131.4 4136.8 4147.8 4170.5 2666.5 2722.0 2737.0 2742.0 2753.3 706.3 829.6 842.4 846.6 847.8 8731.4 8734.8 8743.5 8793.6 8851.7 3904.6 3968.6 3975.5 3985.7 3992.2 8021.7 8045.0 8047.3 8047.5 8047.5 4184.0 4191.4 4194.3 4196.8 4199.8 3811.8 3817.7 3828.7 3840.2 3843.6 3372.7 3404.0 3416.3 3422.5 3457.3 1077.9 1078.0 1083.4 1087.0 1087.6 976.4 989.4 1003.4 1003.8 1004.0 6264.2 6354.0 6356.4 6368.4 6376.8 429.6 430.2 431.2 435.7 437.6 4994.9 5053.4 5054.1 5067.8 5070.5 6972.8 7223.6 8195.7 8258.5 8451.8 7559.9 7698.0 7839.8 7840.1 7847.6 6163.1 6307.3 6318.1 6318.2 6324.1 6259.7 6398.4 6399.0 6410.5 6412.2 7266.6 7350.3 7388.0 7411.0 7460.8 7298.7 7505.7 7522.8 7544.0 7603.7 6126.2 6197.2 6210.7 6226.6 6243.7 5789.2 5962.8 6559.1 6575.4 6627.8 6124.1 6149.9 6163.4 6210.1 6221.3 6014.8 6045.8 6060.2 6157.1 6261.1 6214.2 6229.1 6235.5 6248.8 6257.9 5504.7 5607.9 5608.6 5653.3 5666.2 5768.7 5769.2 5772.5 5784.7 5805.2 01:10:08 INFO - 2015-11-25 01:10:08,201 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,201 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4609.45 Median:5216.60 stddev:1354.48 (26.0%) stddev-sans-first:1319.30 01:10:08 INFO - 2015-11-25 01:10:08,202 DEBUG : BROWSER_OUTPUT: Values: 311.1 311.8 317.5 319.6 323.1 5099.7 5141.1 5274.4 5326.6 5354.5 5038.6 5179.5 5200.4 5215.2 5218.0 3884.9 3972.7 4110.3 4110.8 4119.3 3977.6 4088.8 4100.7 4110.5 4118.7 4063.4 4063.7 4069.0 4071.1 4076.7 4059.9 4066.6 4071.7 4072.6 4079.7 3579.6 3581.0 3581.7 3590.3 3591.9 4938.8 5058.4 5063.2 5068.6 5071.6 4668.7 4668.9 4671.2 4673.3 4676.4 5254.2 5482.6 5497.1 5499.5 5513.2 3752.0 3782.3 3876.0 3880.7 3884.9 5778.1 5839.6 5843.1 5859.1 5885.6 3981.7 3982.4 3984.0 3984.4 3984.8 4043.4 4047.3 4049.7 4052.0 4056.1 4480.9 4581.3 4615.0 4653.6 4658.6 5553.1 5554.9 5560.2 5562.7 5567.6 1411.8 1435.5 1435.8 1437.5 1439.4 967.3 970.3 974.4 995.5 997.1 4909.3 4912.7 4921.2 4921.5 4925.3 5740.4 5747.4 5750.6 5762.1 5772.6 4910.7 4923.4 4925.6 4927.1 4927.8 3006.5 3069.5 3098.5 3100.5 3101.9 5503.4 5559.3 5565.8 5567.9 5570.5 5953.5 5954.1 5962.5 5969.6 5975.8 5503.6 5515.3 5537.6 5539.8 5541.6 5641.7 5767.5 5770.9 5782.9 5786.2 5401.2 5536.1 5567.3 5643.7 5668.4 5490.5 5526.3 5526.7 5528.1 5540.1 3965.2 3999.0 4007.8 4008.2 4009.1 5602.0 5698.3 5757.8 5759.4 5771.5 5557.6 5571.3 5573.0 5575.2 5577.0 5564.4 5567.9 5568.6 5576.9 5581.1 5455.0 5461.4 5470.2 5471.5 5474.2 5409.7 5596.2 5610.9 5613.6 5623.4 5467.5 5485.6 5487.1 5488.7 5492.9 01:10:08 INFO - 2015-11-25 01:10:08,202 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,203 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12377.02 Median:493.84 stddev:14626.19 (2961.7%) stddev-sans-first:14640.66 01:10:08 INFO - 2015-11-25 01:10:08,204 DEBUG : BROWSER_OUTPUT: Values: 640.2 677.6 723.4 752.2 764.3 11060.2 11184.3 11198.3 11203.8 11258.1 11746.1 11852.7 12427.7 12573.1 12588.6 613.0 762.9 773.7 774.4 774.6 612.5 751.8 769.6 770.6 771.8 797.2 809.4 810.0 810.2 810.4 639.3 646.0 777.1 799.8 802.1 587.4 588.0 588.1 588.6 589.0 11044.6 11129.9 11181.7 11182.2 11198.9 9641.3 11387.0 11406.5 11407.3 11611.8 9517.7 9544.6 9596.6 9679.6 9689.0 3174.4 3227.2 3309.7 3320.8 3326.3 42871.6 43944.8 43979.0 44651.8 44691.3 8859.8 8875.1 9022.5 9078.5 9174.3 16173.6 16407.3 16428.3 16439.5 16478.1 6464.1 6471.9 6563.1 6618.7 6770.5 3681.4 3701.2 3712.7 3718.7 3740.5 2764.8 2795.1 2798.9 2802.2 2803.5 487.7 491.7 493.8 493.9 499.4 445.7 454.9 560.2 580.5 589.1 7223.3 7402.4 7410.9 7684.6 7824.7 391.9 488.5 516.9 552.6 591.6 3360.5 3383.9 3626.7 3640.5 3661.2 51854.7 52650.0 52793.5 52834.5 53011.2 45767.1 46547.0 46579.3 46611.0 46613.5 42533.6 43736.6 43903.9 44513.3 44607.8 7270.7 7274.0 7282.5 7436.9 7466.0 29836.6 30225.7 30883.0 32535.7 32870.5 38692.2 39841.2 40545.0 40612.6 40814.4 9468.3 9544.4 9562.1 9593.9 9702.5 10476.4 10523.5 10525.4 10581.7 10959.7 10124.1 10323.5 10362.8 10376.9 10579.2 9994.3 10102.9 10119.0 10360.0 10421.8 8550.2 8622.3 8674.0 8883.9 10234.7 7823.8 8512.8 8608.4 8685.2 8808.0 6963.4 7788.5 7958.4 8038.6 8278.9 01:10:08 INFO - 2015-11-25 01:10:08,204 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:10:08 INFO - 2015-11-25 01:10:08,204 DEBUG : BROWSER_OUTPUT: 01:10:08 INFO - 2015-11-25 01:10:08,958 INFO : Browser exited with error code: 0 01:10:08 INFO - 2015-11-25 01:10:08,979 INFO : Completed test dromaeo_css (00:18:36) 01:10:08 INFO - 2015-11-25 01:10:08,979 INFO : Starting test kraken 01:10:08 INFO - 2015-11-25 01:10:08,979 DEBUG : operating with platform_type : linux_ 01:10:08 INFO - 2015-11-25 01:10:08,979 INFO : Initialising browser for kraken test... 01:10:08 INFO - 2015-11-25 01:10:08,985 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOORdEQ/profile http://localhost:41223/getInfo.html 01:10:12 INFO - 2015-11-25 01:10:12,857 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:10:12 INFO - 2015-11-25 01:10:12,857 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:10:12 INFO - 2015-11-25 01:10:12,857 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:10:12 INFO - 2015-11-25 01:10:12,857 DEBUG : BROWSER_OUTPUT: __metrics 01:10:12 INFO - 2015-11-25 01:10:12,958 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:10:13 INFO - 2015-11-25 01:10:13,607 DEBUG : BROWSER_OUTPUT: console.error: 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: Message: Error: Connection closed before committing the transaction. 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: Stack: 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: ConnectionData.prototype<.executeTransaction/promise resource://gre/modules/Promise-backend.js:934:23 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.walkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:813:7 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: Promise*this.PromiseWalker.scheduleWalkerLoop@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:744:11 01:10:13 INFO - 2015-11-25 01:10:13,611 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.schedulePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:776:7 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: this.PromiseWalker.completePromise@resource://gre/modules/Promise.jsm -> resource://gre/modules/Promise-backend.js:711:7 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: TaskImpl_run@resource://gre/modules/Task.jsm:319:13 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: nsAsyncShutdownBarrier.prototype.wait/<@resource://gre/components/nsAsyncShutdown.js:215:7 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: Spinner.prototype.observe@resource://gre/modules/AsyncShutdown.jsm:529:9 01:10:13 INFO - 2015-11-25 01:10:13,612 DEBUG : BROWSER_OUTPUT: 01:10:14 INFO - 2015-11-25 01:10:14,204 INFO : Browser initialized. 01:10:14 INFO - 2015-11-25 01:10:14,204 INFO : Running cycle 1/1 for kraken test... 01:10:14 INFO - 2015-11-25 01:10:14,205 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpOORdEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:10:26 INFO - 2015-11-25 01:10:26,146 DEBUG : BROWSER_OUTPUT: RSS: Main: 138883072 01:10:26 INFO - 2015-11-25 01:10:26,146 DEBUG : BROWSER_OUTPUT: 01:10:28 INFO - 2015-11-25 01:10:28,775 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-beat-detection) 01:10:29 INFO - 2015-11-25 01:10:29,361 DEBUG : BROWSER_OUTPUT: RSS: Main: 176193536 01:10:29 INFO - 2015-11-25 01:10:29,361 DEBUG : BROWSER_OUTPUT: 01:10:32 INFO - 2015-11-25 01:10:32,078 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-dft) 01:10:32 INFO - 2015-11-25 01:10:32,651 DEBUG : BROWSER_OUTPUT: RSS: Main: 167370752 01:10:32 INFO - 2015-11-25 01:10:32,651 DEBUG : BROWSER_OUTPUT: 01:10:35 INFO - 2015-11-25 01:10:35,662 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-fft) 01:10:36 INFO - 2015-11-25 01:10:36,228 DEBUG : BROWSER_OUTPUT: RSS: Main: 150863872 01:10:36 INFO - 2015-11-25 01:10:36,228 DEBUG : BROWSER_OUTPUT: 01:10:38 INFO - 2015-11-25 01:10:38,282 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41223/tests/kraken/driver.html?testName=audio-oscillator) 01:10:38 INFO - 2015-11-25 01:10:38,848 DEBUG : BROWSER_OUTPUT: RSS: Main: 153710592 01:10:38 INFO - 2015-11-25 01:10:38,848 DEBUG : BROWSER_OUTPUT: 01:10:41 INFO - 2015-11-25 01:10:41,102 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-gaussian-blur) 01:10:41 INFO - 2015-11-25 01:10:41,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 155566080 01:10:41 INFO - 2015-11-25 01:10:41,668 DEBUG : BROWSER_OUTPUT: 01:10:44 INFO - 2015-11-25 01:10:44,657 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-darkroom) 01:10:45 INFO - 2015-11-25 01:10:45,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 155697152 01:10:45 INFO - 2015-11-25 01:10:45,231 DEBUG : BROWSER_OUTPUT: 01:10:48 INFO - 2015-11-25 01:10:48,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41223/tests/kraken/driver.html?testName=imaging-desaturate) 01:10:49 INFO - 2015-11-25 01:10:49,265 DEBUG : BROWSER_OUTPUT: RSS: Main: 156053504 01:10:49 INFO - 2015-11-25 01:10:49,265 DEBUG : BROWSER_OUTPUT: 01:10:52 INFO - 2015-11-25 01:10:52,142 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41223/tests/kraken/driver.html?testName=json-parse-financial) 01:10:52 INFO - 2015-11-25 01:10:52,716 DEBUG : BROWSER_OUTPUT: RSS: Main: 155099136 01:10:52 INFO - 2015-11-25 01:10:52,716 DEBUG : BROWSER_OUTPUT: 01:10:54 INFO - 2015-11-25 01:10:54,551 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41223/tests/kraken/driver.html?testName=json-stringify-tinderbox) 01:10:55 INFO - 2015-11-25 01:10:55,116 DEBUG : BROWSER_OUTPUT: RSS: Main: 166400000 01:10:55 INFO - 2015-11-25 01:10:55,117 DEBUG : BROWSER_OUTPUT: 01:10:56 INFO - 2015-11-25 01:10:56,978 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-aes) 01:10:57 INFO - 2015-11-25 01:10:57,579 DEBUG : BROWSER_OUTPUT: RSS: Main: 162799616 01:10:57 INFO - 2015-11-25 01:10:57,580 DEBUG : BROWSER_OUTPUT: 01:10:59 INFO - 2015-11-25 01:10:59,719 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-ccm) 01:11:00 INFO - 2015-11-25 01:11:00,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 174899200 01:11:00 INFO - 2015-11-25 01:11:00,300 DEBUG : BROWSER_OUTPUT: 01:11:02 INFO - 2015-11-25 01:11:02,855 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 01:11:03 INFO - 2015-11-25 01:11:03,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 180404224 01:11:03 INFO - 2015-11-25 01:11:03,441 DEBUG : BROWSER_OUTPUT: 01:11:06 INFO - 2015-11-25 01:11:06,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 01:11:06 INFO - 2015-11-25 01:11:06,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 178225152 01:11:06 INFO - 2015-11-25 01:11:06,657 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,391 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41223/tests/kraken/driver.html?testName=ai-astar) 01:11:08 INFO - 2015-11-25 01:11:08,642 DEBUG : BROWSER_OUTPUT: RSS: Main: 237572096 01:11:08 INFO - 2015-11-25 01:11:08,643 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,643 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:11:08 INFO - 2015-11-25 01:11:08,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:11:08 INFO - 2015-11-25 01:11:08,643 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:11:08 INFO - 2015-11-25 01:11:08,644 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:11:08 INFO - 2015-11-25 01:11:08,644 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;106;112;113;114;102;111;112;104 01:11:08 INFO - 2015-11-25 01:11:08,644 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;163;134;155;181;129;154;155;141;170;131 01:11:08 INFO - 2015-11-25 01:11:08,644 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;160;160;160;160;160;162;161;160;161 01:11:08 INFO - 2015-11-25 01:11:08,645 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;72;90;97;71;72;72;96;91;73 01:11:08 INFO - 2015-11-25 01:11:08,645 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;139;94;95;94;134;94;95;130 01:11:08 INFO - 2015-11-25 01:11:08,645 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;111;110;110;110;109;109;110;109 01:11:08 INFO - 2015-11-25 01:11:08,646 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;146;147;147;147;145;146;148;148 01:11:08 INFO - 2015-11-25 01:11:08,646 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;95;95;95;95;95;94 01:11:08 INFO - 2015-11-25 01:11:08,646 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;75;75;75;73;80;74;74;72 01:11:08 INFO - 2015-11-25 01:11:08,646 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;67;68;68;69;68;69;68;67 01:11:08 INFO - 2015-11-25 01:11:08,647 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;85;85;83;85;83;83;82;83;92 01:11:08 INFO - 2015-11-25 01:11:08,647 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;136;128;119;121;123;126;128;122;120;126 01:11:08 INFO - 2015-11-25 01:11:08,647 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;154;147;146;151;138;149;148;145;135 01:11:08 INFO - 2015-11-25 01:11:08,647 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;69;68;68;68;69;69;69;69;68 01:11:08 INFO - 2015-11-25 01:11:08,647 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:11:08 INFO - 2015-11-25 01:11:08,648 DEBUG : BROWSER_OUTPUT: __start_cc_report 01:11:08 INFO - 2015-11-25 01:11:08,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,985 01:11:08 INFO - 2015-11-25 01:11:08,648 DEBUG : BROWSER_OUTPUT: __end_cc_report 01:11:08 INFO - 2015-11-25 01:11:08,648 DEBUG : BROWSER_OUTPUT: __startTimestamp1448442668642__endTimestamp 01:11:08 INFO - 2015-11-25 01:11:08,649 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: Number of tests: 14 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.60 Median:112.00 stddev:4.12 (3.7%) stddev-sans-first:4.36 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 106.0 112.0 113.0 114.0 102.0 111.0 112.0 104.0 01:11:08 INFO - 2015-11-25 01:11:08,652 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.30 Median:155.00 stddev:17.38 (11.2%) stddev-sans-first:17.91 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: Values: 163.0 134.0 155.0 181.0 129.0 154.0 155.0 141.0 170.0 131.0 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:160.60 Median:160.50 stddev:0.84 (0.5%) stddev-sans-first:0.73 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: Values: 162.0 160.0 160.0 160.0 160.0 160.0 162.0 161.0 160.0 161.0 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.40 Median:85.00 stddev:10.90 (12.8%) stddev-sans-first:11.54 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: Values: 80.0 72.0 90.0 97.0 71.0 72.0 72.0 96.0 91.0 73.0 01:11:08 INFO - 2015-11-25 01:11:08,653 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.40 Median:94.00 stddev:19.40 (20.6%) stddev-sans-first:20.13 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 139.0 94.0 95.0 94.0 134.0 94.0 95.0 130.0 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 111.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.95 (0.6%) stddev-sans-first:0.97 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 146.0 147.0 147.0 147.0 145.0 146.0 148.0 148.0 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,654 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.33 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 95.0 94.0 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:74.50 stddev:2.12 (2.8%) stddev-sans-first:2.24 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 75.0 75.0 75.0 73.0 80.0 74.0 74.0 72.0 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.00 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 67.0 68.0 68.0 69.0 68.0 69.0 68.0 67.0 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,655 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.00 stddev:3.05 (3.6%) stddev-sans-first:3.00 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: Values: 81.0 85.0 85.0 83.0 85.0 83.0 83.0 82.0 83.0 92.0 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:124.90 Median:126.00 stddev:5.07 (4.0%) stddev-sans-first:3.43 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: Values: 136.0 128.0 119.0 121.0 123.0 126.0 128.0 122.0 120.0 126.0 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.10 Median:148.00 stddev:5.70 (3.9%) stddev-sans-first:6.01 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: Values: 148.0 154.0 147.0 146.0 151.0 138.0 149.0 148.0 145.0 135.0 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.70 Median:69.00 stddev:0.67 (1.0%) stddev-sans-first:0.53 01:11:08 INFO - 2015-11-25 01:11:08,656 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 68.0 68.0 68.0 69.0 69.0 69.0 69.0 68.0 01:11:08 INFO - 2015-11-25 01:11:08,657 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:11:08 INFO - 2015-11-25 01:11:08,657 DEBUG : BROWSER_OUTPUT: 01:11:09 INFO - 2015-11-25 01:11:09,542 INFO : Browser exited with error code: 0 01:11:09 INFO - 2015-11-25 01:11:09,591 INFO : Completed test kraken (00:01:00) 01:11:09 INFO - 2015-11-25 01:11:09,591 INFO : Starting test v8_7 01:11:09 INFO - 2015-11-25 01:11:09,591 DEBUG : operating with platform_type : linux_ 01:11:09 INFO - 2015-11-25 01:11:09,591 INFO : Initialising browser for v8_7 test... 01:11:09 INFO - 2015-11-25 01:11:09,597 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyMf2b/profile http://localhost:41223/getInfo.html 01:11:13 INFO - 2015-11-25 01:11:13,543 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 01:11:13 INFO - 2015-11-25 01:11:13,543 DEBUG : BROWSER_OUTPUT: colorDepth:24 01:11:13 INFO - 2015-11-25 01:11:13,543 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 01:11:13 INFO - 2015-11-25 01:11:13,543 DEBUG : BROWSER_OUTPUT: __metrics 01:11:13 INFO - 2015-11-25 01:11:13,680 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 01:11:14 INFO - 2015-11-25 01:11:14,916 INFO : Browser initialized. 01:11:14 INFO - 2015-11-25 01:11:14,916 INFO : Running cycle 1/1 for v8_7 test... 01:11:14 INFO - 2015-11-25 01:11:14,917 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpmyMf2b/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 01:11:26 INFO - 2015-11-25 01:11:26,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 139169792 01:11:26 INFO - 2015-11-25 01:11:26,811 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,312 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41223/tests/v8_7/run.html (next: http://localhost:41223/tests/v8_7/run.html) 01:11:48 INFO - 2015-11-25 01:11:48,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 450129920 01:11:48 INFO - 2015-11-25 01:11:48,562 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: __start_tp_report 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |0;Richards;165.31658125309968 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.38755980861245 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5175.257731958763 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1990.0596421471173 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |5;Earley;803.370786516854 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |6;Boyer;12518.518518518518 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |7;RegExp;26710.526315789473 01:11:48 INFO - 2015-11-25 01:11:48,563 DEBUG : BROWSER_OUTPUT: |8;Splay;594.6745562130177 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: __end_tp_report 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: __startTimestamp1448442708559__endTimestamp 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: Number of tests: 10 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:165.32 Median:165.32 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: Values: 165.3 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.39 Median:191.39 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: Values: 191.4 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,564 DEBUG : BROWSER_OUTPUT: Values: 277.5 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5175.26 Median:5175.26 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: Values: 5175.3 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1990.06 Median:1990.06 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: Values: 1990.1 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.37 Median:803.37 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: Values: 803.4 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12518.52 Median:12518.52 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: Values: 12518.5 01:11:48 INFO - 2015-11-25 01:11:48,565 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26710.53 Median:26710.53 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: Values: 26710.5 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:594.67 Median:594.67 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: Values: 594.7 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 01:11:48 INFO - 2015-11-25 01:11:48,566 DEBUG : BROWSER_OUTPUT: Values: 4830.9 01:11:48 INFO - 2015-11-25 01:11:48,567 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 01:11:48 INFO - 2015-11-25 01:11:48,567 DEBUG : BROWSER_OUTPUT: 01:11:49 INFO - 2015-11-25 01:11:49,473 INFO : Browser exited with error code: 0 01:11:49 INFO - 2015-11-25 01:11:49,490 INFO : Completed test v8_7 (00:00:39) 01:11:49 INFO - 2015-11-25 01:11:49,494 INFO : Completed test suite (00:20:16) 01:11:49 INFO - 2015-11-25 01:11:49,494 DEBUG : Working with test: dromaeo_css 01:11:49 INFO - 2015-11-25 01:11:49,494 DEBUG : Generating results file: dromaeo_css 01:11:49 INFO - 2015-11-25 01:11:49,495 DEBUG : Working with test: kraken 01:11:49 INFO - 2015-11-25 01:11:49,495 DEBUG : Generating results file: kraken 01:11:49 INFO - 2015-11-25 01:11:49,495 INFO : javascript benchmark 01:11:49 INFO - 2015-11-25 01:11:49,495 DEBUG : Working with test: v8_7 01:11:49 INFO - 2015-11-25 01:11:49,495 DEBUG : Generating results file: v8_7 01:11:49 INFO - 2015-11-25 01:11:49,495 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:49 INFO - 2015-11-25 01:11:49,552 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,35]] 01:11:49 INFO - 2015-11-25 01:11:49,553 DEBUG : process_Request line: dromaeo_css 6241.09 graph.html#tests=[[72,132,35]] 01:11:49 INFO - 2015-11-25 01:11:49,553 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:49 INFO - 2015-11-25 01:11:49,587 DEBUG : process_Request line: kraken 1527.20 graph.html#tests=[[232,132,35]] 01:11:49 INFO - 2015-11-25 01:11:49,587 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 01:11:49 INFO - 2015-11-25 01:11:49,619 DEBUG : process_Request line: v8_7 19727.10 graph.html#tests=[[230,132,35]] 01:11:49 INFO - 2015-11-25 01:11:49,624 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2612.7126016138222, 2710.2140379289995, 2725.1824452664196, 2735.206790030891, 2735.617013618093, 4392.209402307583, 4478.305862591295, 4520.0, 4571.131485017849, 4595.356650068993, 4475.820967161318, 4508.323751437278, 4575.542445755423, 4589.105124500724, 4629.884252893679, 4178.206140833247, 4212.747235165884, 4215.768132752697, 4272.893177670568, 4286.078493123978, 4073.103917138225, 4258.659307255428, 4291.570842915699, 4308.46144231971, 4346.087321662455, 4111.198316328332, 4143.440635514197, 4209.494860616715, 4213.115245798386, 4237.237297286487, 4217.030083080878, 4221.345691417835, 4238.067625122468, 4265.466816647919, 4282.8715138545895, 4022.9597704022876, 4123.092919557693, 4202.768847713374, 4220.240356735786, 4252.87241382759, 4453.51011388747, 4463.665225108098, 4517.503074661785, 4531.8187272509385, 4558.954410455886, 4856.101621200054, 4858.854234372974, 4860.8055677772845, 4862.635302352338, 4902.803887844482, 4701.78841952113, 4841.878953026167, 4889.951100489021, 4894.975525122351, 4920.6801557898625, 4429.202743506167, 4540.9772951135365, 4575.336576196433, 4593.839215627437, 4629.629629629621, 4950.4059512858685, 4973.378327709036, 4976.8755781105765, 5014.724190169576, 5015.573676237488, 4630.536946305342, 4746.359241502422, 4748.572628463455, 4763.595094417014, 4800.423949126127, 4761.35721677576, 4790.4251489821445, 4824.662273640812, 4852.805887764521, 4891.877703057452, 4813.638977076734, 4814.687045342112, 4817.710937343771, 4858.78135483904, 4880.877978050577, 4619.3994780678295, 4727.078219747185, 4807.567318941312, 4823.2282834746275, 4845.466998630148, 4016.116454380032, 4038.8586399475876, 4066.054679704662, 4085.9182816343505, 4117.608827161415, 3545.468179773003, 3547.219611685425, 3573.4282514797505, 3579.534660494119, 3586.8206589670413, 4062.5937406259727, 4167.5832416758085, 4261.97869010653, 4266.637335826427, 4267.25323068468, 4791.281307803857, 4844.806207751651, 4910.803567857246, 4945.455999840086, 4957.454679985199, 4197.5172855122055, 4202.159568086395, 4211.410402543646, 4220.008298049956, 4253.255680255943, 4298.699091063596, 4302.204092242945, 4322.805473753689, 4346.739195648208, 4379.1241751649795, 4424.446944131983, 4544.590986811269, 4547.363369128391, 4629.67592268538, 4830.227163653799, 4909.926351104665, 4927.531884470969, 4929.408470983505, 4936.533844456774, 4975.253711943093, 4707.552782485658, 4710.1757192490495, 4714.387129673258, 4717.457492388282, 4758.88102797419, 4606.6314694825005, 4713.128071306819, 4714.457837348612, 4800.591949684176, 4919.3604831371695, 4882.804687812448, 4888.0, 4893.877653058702, 4898.8402480400655, 4931.408231012158, 4739.099571081483, 4740.2178640523925, 4746.762661866824, 4747.311639812277, 4786.1624215762795, 4537.274036154199, 4640.559146881041, 4652.813887444464, 4712.151812673752, 4824.372831531879, 4628.884277893079, 4658.557437043475, 4658.557437043475, 4675.462321833033, 4695.788689509049, 4759.714417134983, 4777.665563410667, 4778.307145463958, 4817.13291607514, 4820.204666230033, 4565.292379681155, 4638.095571363552, 4679.087577922409, 4684.180268453075, 4713.2458806590785], "unit": "ms", "name": "dojo.html", "value": 4473.093185543327}, {"lowerIsBetter": false, "replicates": [575.1717526761463, 575.1975993489083, 575.6977586766947, 578.69040063566, 581.9272590926134, 28331.0, 28903.277418064532, 34376.82811585942, 34443.827780861124, 34590.8270458648, 38842.417363739565, 39482.210355792864, 39499.802500987455, 39522.604773952255, 39561.802190989, 6960.930390696104, 7946.404019698517, 8113.594320283992, 8113.8782918256275, 8114.391420643446, 6998.68505917235, 10183.745406364864, 10370.896291037106, 10471.267011309212, 10494.790104197911, 10083.798324033514, 10138.645147419842, 10163.0, 10173.694789156338, 10182.338148020392, 7178.928210717878, 7346.632668366614, 9916.157126644244, 9976.002399760002, 10185.439800810953, 9903.108720215143, 10078.79842403155, 10090.990900909923, 10110.19118470528, 10123.746906327327, 37725.43411848824, 38020.61979380198, 38103.23793524114, 38207.23585528302, 38520.22959540794, 2780.3605170810624, 2811.395549956769, 2847.2170153207826, 2853.6004959305715, 3497.7901325920525, 27785.722142778515, 28062.85968570144, 28086.719132808616, 28424.71575284262, 28467.28831779222, 3440.6043305019743, 3505.526753888218, 3527.8236088195745, 3577.2487777566744, 3638.8362523686233, 221110.0, 222889.99999999837, 223434.0, 223659.99999999837, 223980.0, 51337.48662513402, 55778.72110639421, 55862.0, 55997.72001139968, 56195.0, 49717.0, 60574.0, 61916.07125893115, 61953.0, 62053.0, 13025.283609401575, 13241.205527668371, 13241.73516529664, 13253.602391928258, 13258.270795106362, 9564.0, 9578.329516933887, 9586.760330991781, 9589.328746987783, 9589.952050239845, 19237.903810480857, 19345.806541934682, 19457.61084778325, 19466.70799938002, 19481.73368731028, 7454.85090298191, 7790.805229869298, 7800.453968222283, 7814.335781458526, 7998.4001199910235, 836.460482988469, 859.9183077607618, 890.8396488631979, 951.6811868024289, 983.3952119446488, 27098.86450567774, 27136.457270854473, 27564.0, 27580.724192757814, 27592.862035689694, 947.9526023698926, 960.8222478841436, 988.8430536272579, 1007.652359935821, 1070.7055559720984, 13819.0, 14051.367688454044, 15467.767983480257, 16483.752743708854, 16501.257443415074, 329460.0, 334614.0, 335159.0, 335218.0, 336028.0, 50151.498485015414, 50689.23966140511, 50764.74617626962, 50778.41437441878, 50782.0, 1219.0856857356982, 1219.5609580550995, 1236.3323805145121, 1239.3926975781983, 1239.9876001240052, 27815.860920695268, 28635.140945770825, 28810.991615293366, 28967.275818104717, 29213.561796573493, 36410.27179456343, 37187.81406092952, 43240.135197296506, 43606.56393436025, 44256.557434425245, 199071.0, 199811.0, 201389.0, 201542.0, 201559.0, 36102.0, 36654.81672591727, 36657.0, 36672.63327366692, 36689.26621467502, 42352.5764742361, 42565.0, 42664.14671706486, 42861.78569107259, 43033.0, 36173.457398138526, 36627.45058824173, 37008.259834802615, 37058.0, 37502.62497375101, 36318.636813632584, 36608.45087323745, 37779.62220377871, 39179.41230881596, 39683.0, 34937.30125397427, 35133.121671958404, 35189.47215791714, 35200.471992919614, 38435.6156438432, 28962.710372896003, 30473.390532188787, 31251.37497250088, 31277.0, 31379.215519612193, 23970.40073998164, 24376.390590235387, 24492.87753561221, 24507.50984980326, 24587.262382128563], "unit": "ms", "name": "ext.html", "value": 17706.037162590765}, {"lowerIsBetter": false, "replicates": [341.6941837055835, 342.1565840203897, 343.22088858291676, 343.3390722858497, 344.89997900608824, 12228.93885530571, 12572.559960401388, 15224.162671053102, 15324.923375383121, 15979.961302515343, 12629.179103358276, 14616.342264598092, 15084.773728394082, 15547.92226038871, 15552.922235388836, 4715.151272770909, 4887.218045112782, 5013.498650134994, 5162.793488260465, 5176.7411629418375, 3351.715104216132, 3495.5281037059926, 5070.974645126769, 5093.414257360396, 5102.387713474388, 5113.386393632769, 5226.503482169207, 5244.0, 5245.973770131144, 5248.107821670325, 5178.40448348441, 5215.322008138936, 5215.765290561933, 5219.739013049351, 5358.91961620576, 5219.451957544441, 5225.111731005738, 5227.398849132361, 5242.764075616568, 5245.763940622643, 18145.0, 18210.63578728431, 18266.543336416562, 18669.973151476664, 18703.43889683298, 1668.3243286468999, 1842.0, 1866.178881292227, 1883.5385330594092, 1950.3466338776527, 8905.599248033854, 8974.102589741038, 9039.186473217442, 9173.58718857653, 9252.444853308823, 1759.8050187768933, 1767.460924418052, 1785.8482029027548, 1787.6692811829723, 1822.298415110179, 53219.73390133025, 56099.71950140223, 57307.426925731044, 57480.42519574834, 57912.71043644797, 10010.349327293703, 10019.549120289605, 10028.097471227624, 10056.949715251378, 10069.848952265722, 12730.68173295675, 12731.10882238253, 12734.108612397229, 12751.61745147647, 12755.93622031884, 6744.0, 7012.789616311519, 7017.789466316019, 7077.3984211341585, 7133.286671332929, 6344.524160687967, 6440.388163124496, 6536.869262614721, 6678.365555272241, 6740.022696708949, 4192.7065105442325, 4212.0, 4217.219814334358, 4243.8090285937205, 4256.936145957751, 1591.816941051794, 1643.047032721019, 1719.2263481433406, 1761.0842361971959, 1789.8210178981997, 386.12735218406044, 387.60270722509654, 842.6839935024366, 883.4037025008093, 965.7633879699519, 9654.324197306121, 10116.393016419039, 14931.477398291008, 15799.842001579837, 15899.841001590068, 723.989140162898, 803.477739469338, 858.7295002074327, 866.3978534918172, 866.5580553917422, 8634.913650863411, 8861.025287218401, 8942.86585701215, 8978.595963181673, 8985.371024028385, 338467.0, 339921.0, 340267.0, 341114.0, 346329.0, 60751.69624151939, 60804.69597651983, 60892.69553652292, 61285.38714612886, 63809.68095159494, 1040.7138037039874, 1068.770214403907, 1070.053003092269, 1081.6376513867942, 1082.3235477826358, 13562.525311614047, 14251.786223206867, 14264.429422823387, 14307.64230894236, 14497.565073047825, 28330.716692833634, 28912.855435722686, 32725.0, 33441.163970900925, 34102.0, 42655.57344426516, 42811.57188428076, 44505.55494445014, 44516.109677805616, 44524.332135018645, 13208.603741887759, 13294.401751920994, 13635.318234088454, 13661.863381366456, 13754.381052852446, 17586.20862061236, 17668.0, 17961.640767184843, 18186.636267274316, 18403.815961840744, 2385.85684858909, 10747.677569672922, 14363.56909292723, 14424.8460123192, 14799.408023678932, 14124.223167725873, 14165.15009099416, 14555.41778328855, 14651.94872717799, 15010.624734381729, 14137.36381862798, 14182.645433864236, 14188.574342769733, 14972.176530290502, 15261.23693815327, 13439.865601344252, 13575.660608484866, 13590.59228223155, 13715.657108572366, 13725.0, 14228.430862765374, 14583.125012499284, 14630.926845365704, 14678.633034173803, 14822.110673359633], "unit": "ms", "name": "jquery.html", "value": 8257.075312799825}, {"lowerIsBetter": false, "replicates": [1407.7254935287624, 1586.7540531217662, 1635.4112519492987, 1649.645326254855, 1673.121611154144, 5804.593678442506, 6088.878222435548, 6836.316368363167, 7068.187158476777, 7129.89305160423, 7094.432445404368, 7118.466115041379, 7162.1763497197835, 7171.9641401792915, 7207.42340612751, 1743.43338415015, 1778.510909499885, 2044.4582185720797, 2077.27295446594, 2079.480129967508, 2079.7504299484085, 2113.080809847721, 2119.247667078188, 2121.427214652043, 2122.4269447249235, 2010.8491863110253, 2046.6827641715558, 2048.5902819436096, 2051.507638166837, 2053.9589208215825, 2060.1965233558926, 2080.8959552022416, 2107.2835236019673, 2109.3461027081653, 2111.873287602741, 2042.3260324093014, 2065.1945741160957, 2066.8966551672506, 2069.7619773726065, 2070.8343332533514, 6932.514723969324, 6939.23668396476, 6973.267806880306, 6985.161780586312, 7021.719131234744, 4031.7580945143386, 4131.421600975866, 4136.772477513736, 4147.771872547009, 4170.52039015511, 2666.4533770576986, 2722.0472834507964, 2736.9589456158174, 2741.972580274192, 2753.2703833484143, 706.2584286499207, 829.6266679994027, 842.4397775479299, 846.5936350551708, 847.7838151271447, 8731.388802783807, 8734.825303493959, 8743.475391476468, 8793.648254069829, 8851.690190843354, 3904.590018048064, 3968.57131432684, 3975.483187185705, 3985.740926839804, 3992.2215168042535, 8021.679132834622, 8045.034595848536, 8047.315978141806, 8047.476914000571, 8047.51714897108, 4184.016756062323, 4191.371294305878, 4194.30793919006, 4196.790160491963, 4199.832006719758, 3811.8284677189595, 3817.7327587069194, 3828.655421012122, 3840.1935593525673, 3843.557990831034, 3372.6795954384293, 3404.0, 3416.265502916885, 3422.486627005919, 3457.291255292659, 1077.8868218837067, 1078.0351585331084, 1083.3987137138963, 1086.9673909782719, 1087.635642059903, 976.3604838830578, 989.351974456732, 1003.4430890855499, 1003.8092762375126, 1004.0110491166196, 6264.1856558648, 6353.96823015882, 6356.3961423665605, 6368.39500247485, 6376.808695739135, 429.5747210261818, 430.2384778941319, 431.20873197681976, 435.6667149630535, 437.5908525528641, 4994.850154495371, 5053.418856831438, 5054.064997975386, 5067.771950262247, 5070.467600901852, 6972.825679358057, 7223.566586004751, 8195.71315003984, 8258.504489730636, 8451.830963380698, 7559.886601700979, 7698.0, 7839.764807055797, 7840.059192896889, 7847.607619619111, 6163.075538669235, 6307.337729538424, 6318.083877837687, 6318.210223722035, 6324.1146239527425, 6259.687015649109, 6398.360163983564, 6399.0, 6410.519211059096, 6412.198475190601, 7266.636668166676, 7350.3384695375535, 7387.963060184665, 7410.96294518524, 7460.776176714708, 7298.6715597797165, 7505.66224519887, 7522.849543009219, 7544.0192774938905, 7603.7338693145475, 6126.23422072241, 6197.225346831646, 6210.720517576629, 6226.5641405101205, 6243.719032643451, 5789.218455508452, 5962.791302304398, 6559.14731084975, 6575.408213260829, 6627.768028118992, 6124.14262003311, 6149.938500614937, 6163.3836616338, 6210.130581718473, 6221.2845522765465, 6014.8195554133445, 6045.78839740607, 6060.181875446759, 6157.076438534255, 6261.123442717932, 6214.161088253209, 6229.096780966644, 6235.532335074979, 6248.750049997949, 6257.874842503215, 5504.669719816824, 5607.915881261866, 5608.6073974821375, 5653.293338332708, 5666.15007748841, 5768.7404066817935, 5769.221155144001, 5772.451617096369, 5784.739686714024, 5805.187273781589], "unit": "ms", "name": "mootools.html", "value": 3881.0967699079974}, {"lowerIsBetter": false, "replicates": [311.1055714819893, 311.8020057263637, 317.4682406968329, 319.60369142263585, 323.05506393798134, 5099.668521546097, 5141.126008578542, 5274.367075950881, 5326.600504962129, 5354.518093371596, 5038.571721403685, 5179.482051794818, 5200.4019537753165, 5215.217717342391, 5217.973910130444, 3884.9028774280728, 3972.7020473464463, 4110.342345224764, 4110.794460276989, 4119.258533463975, 3977.602239776028, 4088.8364465421346, 4100.712950093494, 4110.547839737626, 4118.691098167635, 4063.3701776224584, 4063.6952228582827, 4069.0, 4071.084006098634, 4076.694247931402, 4059.8579049733266, 4066.552679205285, 4071.653909417703, 4072.552019277877, 4079.714419990602, 3579.588347340063, 3581.0, 3581.7492775505725, 3590.335787879251, 3591.94612080819, 4938.827141050046, 5058.418281897592, 5063.1898896176435, 5068.645194836363, 5071.594272458195, 4668.719876807402, 4668.929966050512, 4671.229247174212, 4673.252279635242, 4676.438827340707, 5254.15933450646, 5482.643628164156, 5497.065498865202, 5499.50504454601, 5513.228148059275, 3751.9624803751885, 3782.2813665403487, 3875.961240387588, 3880.708946828971, 3884.9223015539533, 5778.075507918713, 5839.591228614041, 5843.065109582489, 5859.121131830217, 5885.646861188342, 3981.6814654827544, 3982.3628219484744, 3983.960160398417, 3984.382420724792, 3984.8406063757707, 4043.393490976377, 4047.3321901886447, 4049.6962727795535, 4052.0, 4056.1076563156057, 4480.910381792346, 4581.266997280486, 4615.0, 4653.604443622262, 4658.604018658384, 5553.111502159635, 5554.861128471821, 5560.193771903132, 5562.721863906789, 5567.55459563242, 1411.7529432349297, 1435.4617018618019, 1435.806166167575, 1437.5112461763051, 1439.4242303078643, 967.2697113679127, 970.3110791338088, 974.4250891973769, 995.4723996281982, 997.1175509673845, 4909.26361045846, 4912.70523768575, 4921.163402221631, 4921.483244259372, 4925.285833554115, 5740.368559458456, 5747.3677895431465, 5750.597458177887, 5762.135679648002, 5772.624779389326, 4910.705357678551, 4923.384576927884, 4925.556699897026, 4927.137750893651, 4927.827526036572, 3006.4888968875343, 3069.524223745323, 3098.5042393216977, 3100.472919603673, 3101.937961240808, 5503.422140675251, 5559.33288005442, 5565.777368905279, 5567.944320556742, 5570.470805273492, 5953.493953014043, 5954.136650185699, 5962.493188078975, 5969.641821490724, 5975.790847320323, 5503.587230957694, 5515.338159420895, 5537.5569954404355, 5539.806106786324, 5541.556675465953, 5641.746121424628, 5767.5385969121535, 5770.942290577041, 5782.942170578241, 5786.247787787561, 5401.189821526802, 5536.114221724666, 5567.3040869891265, 5643.717814109196, 5668.376478587435, 5490.450954904478, 5526.281583394133, 5526.668399896019, 5528.115501519898, 5540.085885828793, 3965.1673148637956, 3998.9602703297933, 4007.8196481157834, 4008.1783234437453, 4009.0979529605606, 5602.0, 5698.2592263005545, 5757.798477053283, 5759.424057594207, 5771.538276937751, 5557.638753481011, 5571.331440227199, 5573.024720673785, 5575.1915972184615, 5576.972115139561, 5564.387917329172, 5567.916481252703, 5568.638038527482, 5576.888462230651, 5581.10702287632, 5455.0, 5461.371942226695, 5470.206820011155, 5471.452854714496, 5474.151506516497, 5409.702466364388, 5596.18855265976, 5610.943890561205, 5613.550915926798, 5623.3814280428305, 5467.4532546745, 5485.561155107662, 5487.067198576172, 5488.670679759227, 5492.890142197213], "unit": "ms", "name": "prototype.html", "value": 4179.868559682931}, {"lowerIsBetter": false, "replicates": [640.2445114764579, 677.6408503493147, 723.4140346319485, 752.180123665205, 764.3083009876062, 11060.170487213461, 11184.32894026359, 11198.272112312694, 11203.831942520848, 11258.099352051837, 11746.119041071932, 11852.703682407944, 12427.68930776731, 12573.11988160829, 12588.622341329774, 613.0161091448206, 762.9351505122057, 773.6673230510878, 774.44240147094, 774.6281784743327, 612.5038718637918, 751.77070993347, 769.5998080997878, 770.5646309834925, 771.7993321736361, 797.2266901105918, 809.3686924199134, 809.9595020248994, 810.222186700768, 810.3962547901822, 639.2744235292953, 645.9547831651786, 777.0869228656306, 799.8400319936007, 802.1176705623797, 587.3803137689736, 588.0268156201494, 588.0796553393925, 588.5556404914305, 589.0281036290113, 11044.558217671283, 11129.885321788915, 11181.664550063511, 11182.16133789969, 11198.888011119947, 9641.27690423221, 11387.0, 11406.543738250542, 11407.31556106628, 11611.825822612667, 9517.714468565884, 9544.61821527145, 9596.616135354578, 9679.564419601065, 9689.0, 3174.4444722173525, 3227.209333713232, 3309.6855798699085, 3320.750943679234, 3326.284848757529, 42871.57128428707, 43944.78027609905, 43979.0, 44651.77674111641, 44691.32963005525, 8859.822803543893, 8875.068117847663, 9022.458652480873, 9078.54607269634, 9174.311926605531, 16173.59566010859, 16407.261673224733, 16428.260728267258, 16439.506814795575, 16478.09370484611, 6464.062710906892, 6471.935280647133, 6563.146790917151, 6618.7352505899225, 6770.45836333102, 3681.4109742441083, 3701.2227432239533, 3712.7215458840697, 3718.6839118674675, 3740.532433445819, 2764.7926405519665, 2795.147480018614, 2798.9300267493477, 2802.1873656639345, 2803.509385857467, 487.74637188662405, 491.68532139430795, 493.7777999900059, 493.9110960027158, 499.4406264983242, 445.6657506869848, 454.8749093999111, 560.1933216168785, 580.506569415993, 589.0545674192858, 7223.349898509055, 7402.407807375397, 7410.888836667455, 7684.577348245788, 7824.726134585262, 391.91965647042286, 488.5236894028294, 516.860447679132, 552.6269767906647, 591.6331874237914, 3360.479125735515, 3383.932321353559, 3626.6917312028772, 3640.5449318835144, 3661.212839239576, 51854.74072629613, 52650.0, 52793.472065279624, 52834.47165528373, 53011.20483192755, 45767.084658306645, 46547.0, 46579.30131048037, 46611.0, 46613.533864660916, 42533.57466425358, 43736.56263437325, 43903.926725128935, 44513.33230001553, 44607.77696111563, 7270.709171633075, 7274.0, 7282.526635768658, 7436.851262974818, 7466.0, 29836.552451712807, 30225.697743022287, 30883.0, 32535.698572057798, 32870.506942396365, 38692.22615547617, 39841.2031759369, 40545.0, 40612.59387406088, 40814.387784183855, 9468.337216394786, 9544.379615324982, 9562.139407453084, 9593.856092158763, 9702.5148742564, 10476.423796691255, 10523.473826308807, 10525.36847789135, 10581.735456613646, 10959.726006849893, 10124.08883200486, 10323.535440905027, 10362.792744145225, 10376.948115259678, 10579.206559508222, 9994.250431217833, 10102.949485252526, 10119.0, 10359.950105926066, 10421.791564168523, 8550.228367236195, 8622.310215182895, 8673.956630216808, 8883.911160888567, 10234.692959211236, 7823.8435231293915, 8512.829743405222, 8608.397412181088, 8685.218330350299, 8808.0, 6963.442924565921, 7788.454808163374, 7958.363330933627, 8038.598070096355, 8278.875816862632], "unit": "ms", "name": "yui.html", "value": 5569.787260547675}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 106.0, 112.0, 113.0, 114.0, 102.0, 111.0, 112.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 109.6}, {"lowerIsBetter": true, "replicates": [163.0, 134.0, 155.0, 181.0, 129.0, 154.0, 155.0, 141.0, 170.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.3}, {"lowerIsBetter": true, "replicates": [162.0, 160.0, 160.0, 160.0, 160.0, 160.0, 162.0, 161.0, 160.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 160.6}, {"lowerIsBetter": true, "replicates": [80.0, 72.0, 90.0, 97.0, 71.0, 72.0, 72.0, 96.0, 91.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.4}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 139.0, 94.0, 95.0, 94.0, 134.0, 94.0, 95.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.4}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 145.0, 146.0, 148.0, 148.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0, 94.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 75.0, 75.0, 75.0, 73.0, 80.0, 74.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 67.0, 68.0, 68.0, 69.0, 68.0, 69.0, 68.0, 67.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.0}, {"lowerIsBetter": true, "replicates": [81.0, 85.0, 85.0, 83.0, 85.0, 83.0, 83.0, 82.0, 83.0, 92.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [136.0, 128.0, 119.0, 121.0, 123.0, 126.0, 128.0, 122.0, 120.0, 126.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 124.9}, {"lowerIsBetter": true, "replicates": [148.0, 154.0, 147.0, 146.0, 151.0, 138.0, 149.0, 148.0, 145.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 146.1}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 69.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.7}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [165.31658125309968], "unit": "score", "name": "Richards", "value": 213.54179800000009}, {"lowerIsBetter": false, "replicates": [191.38755980861245], "unit": "score", "name": "DeltaBlue", "value": 345.4665499999999}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5175.257731958763], "unit": "score", "name": "Decrypt", "value": 51.433380478087685}, {"lowerIsBetter": false, "replicates": [1990.0596421471173], "unit": "score", "name": "RayTrace", "value": 371.84262437562455}, {"lowerIsBetter": false, "replicates": [803.370786516854], "unit": "score", "name": "Earley", "value": 829.5833146853149}, {"lowerIsBetter": false, "replicates": [12518.518518518518], "unit": "score", "name": "Boyer", "value": 53.238168639053214}, {"lowerIsBetter": false, "replicates": [26710.526315789473], "unit": "score", "name": "RegExp", "value": 34.105842364532016}, {"lowerIsBetter": false, "replicates": [594.6745562130177], "unit": "score", "name": "Splay", "value": 137.03461691542284}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7"}]} 01:11:49 INFO - RETURN: dromaeo_css: 6241.09 01:11:49 INFO - RETURN: kraken: 1527.20 01:11:49 INFO - RETURN: v8_7: 19727.10 01:11:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,35]]", "result": "19727.10"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,35]]", "result": "1527.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,35]]", "result": "6241.09"}}} 01:11:49 INFO - Return code: 0 01:11:49 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 01:11:49 INFO - # TBPL SUCCESS # 01:11:49 INFO - Running post-action listener: _resource_record_post_action 01:11:49 INFO - Running post-run listener: _resource_record_post_run 01:11:50 INFO - Total resource usage - Wall time: 1231s; CPU: 13.0%; Read bytes: 8192; Write bytes: 501768192; Read time: 140; Write time: 522112 01:11:50 INFO - install - Wall time: 15s; CPU: 15.0%; Read bytes: 4096; Write bytes: 225210368; Read time: 92; Write time: 339984 01:11:50 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276557824; Read time: 48; Write time: 182128 01:11:50 INFO - Running post-run listener: _upload_blobber_files 01:11:50 INFO - Blob upload gear active. 01:11:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 01:11:50 INFO - Copying logs to upload dir... 01:11:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1274.946105 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 14 secs) (at 2015-11-25 01:11:50.554479) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 01:11:50.557774) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test/properties SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010053 build_url: 'https://queue.taskcluster.net/v1/task/qi5EcGL3RviBLlPX8IXPGw/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-25 01:11:50.609150) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:11:50.609491) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: DISPLAY=:0 HOME=/home/cltbld LANG=en_US.UTF-8 LANGUAGE=en_US:en LOGNAME=cltbld MAIL=/var/mail/cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NODE_PATH=/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript NO_EM_RESTART=1 PATH=/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games PWD=/builds/slave/test SHELL=/bin/bash SHLVL=1 TERM=linux TMOUT=86400 USER=cltbld XDG_SESSION_COOKIE=820bb6602ddf640013a48df2000001a9-1448440742.384064-515465624 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004462 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 01:11:50.659687) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:11:50.660015) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 01:11:50.660325) ========= ========= Total master_lag: 0.22 =========