builder: fx-team_ubuntu64_hw_test-dromaeojs-e10s slave: talos-linux64-ix-008 starttime: 1448517997.99 results: success (0) buildid: 20151125214012 builduid: 6712597707194299a0f43970d8439207 revision: 23eb26d374c6bb374cf7f2b23a77a7147f7a5371 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:37.992652) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:37.993283) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:37.993678) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006500 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.067580) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.067941) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.085425) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.085780) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004656 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.137724) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.138046) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.138432) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.138736) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 22:06:38-- 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% 222M=0s 2015-11-25 22:06:38 (222 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.118503 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.271379) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.271729) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.022552 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.322607) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.323078) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 23eb26d374c6bb374cf7f2b23a77a7147f7a5371 --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 23eb26d374c6bb374cf7f2b23a77a7147f7a5371 --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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 22:06:38,732 truncating revision to first 12 chars 2015-11-25 22:06:38,732 Setting DEBUG logging. 2015-11-25 22:06:38,732 attempt 1/10 2015-11-25 22:06:38,732 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/23eb26d374c6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 22:06:39,072 unpacking tar archive at: fx-team-23eb26d374c6/testing/mozharness/ program finished with exit code 0 elapsedTime=0.640229 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.977332) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.977755) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.989488) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.989800) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 22:06:38.990243) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-25 22:06:38.990615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --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-e10s', '--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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:06:39 INFO - MultiFileLogger online at 20151125 22:06:39 in /builds/slave/test 22:06:39 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --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 22:06:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:06:39 INFO - {'append_to_log': False, 22:06:39 INFO - 'base_work_dir': '/builds/slave/test', 22:06:39 INFO - 'blob_upload_branch': 'Fx-Team-Non-PGO', 22:06:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:06:39 INFO - 'branch': 'Fx-Team-Non-PGO', 22:06:39 INFO - 'buildbot_json_path': 'buildprops.json', 22:06:39 INFO - 'config_files': ('talos/linux_config.py',), 22:06:39 INFO - 'default_actions': ('clobber', 22:06:39 INFO - 'read-buildbot-config', 22:06:39 INFO - 'download-and-extract', 22:06:39 INFO - 'populate-webroot', 22:06:39 INFO - 'create-virtualenv', 22:06:39 INFO - 'install', 22:06:39 INFO - 'run-tests'), 22:06:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:06:39 INFO - 'download_minidump_stackwalk': True, 22:06:39 INFO - 'download_symbols': 'ondemand', 22:06:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:06:39 INFO - 'tooltool.py': '/tools/tooltool.py', 22:06:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:06:39 INFO - '/tools/misc-python/virtualenv.py')}, 22:06:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:06:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:06:39 INFO - 'installer_path': 'installer.exe', 22:06:39 INFO - 'log_level': 'info', 22:06:39 INFO - 'log_name': 'talos', 22:06:39 INFO - 'log_to_console': True, 22:06:39 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:06:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:06:39 INFO - 'opt_config_files': (), 22:06:39 INFO - 'pip_index': False, 22:06:39 INFO - 'sps_profile': False, 22:06:39 INFO - 'sps_profile_interval': 0, 22:06:39 INFO - 'suite': 'dromaeojs-e10s', 22:06:39 INFO - 'system_bits': '64', 22:06:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:06:39 INFO - 'title': 'talos-linux64-ix-008', 22:06:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:06:39 INFO - 'use_talos_json': True, 22:06:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:06:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:06:39 INFO - 'work_dir': 'build'} 22:06:39 INFO - ##### 22:06:39 INFO - ##### Running clobber step. 22:06:39 INFO - ##### 22:06:39 INFO - Running pre-action listener: _resource_record_pre_action 22:06:39 INFO - Running main action method: clobber 22:06:39 INFO - rmtree: /builds/slave/test/build 22:06:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:06:39 INFO - Running post-action listener: _resource_record_post_action 22:06:39 INFO - ##### 22:06:39 INFO - ##### Running read-buildbot-config step. 22:06:39 INFO - ##### 22:06:39 INFO - Running pre-action listener: _resource_record_pre_action 22:06:39 INFO - Running main action method: read_buildbot_config 22:06:39 INFO - Using buildbot properties: 22:06:39 INFO - { 22:06:39 INFO - "properties": { 22:06:39 INFO - "buildnumber": 733, 22:06:39 INFO - "product": "firefox", 22:06:39 INFO - "script_repo_revision": "production", 22:06:39 INFO - "builddir": "fx-team_ubuntu64_hw_test-dromaeojs-e10s", 22:06:39 INFO - "repository": "", 22:06:39 INFO - "buildername": "Ubuntu HW 12.04 x64 fx-team talos dromaeojs-e10s", 22:06:39 INFO - "buildid": "20151125214012", 22:06:39 INFO - "slavename": "talos-linux64-ix-008", 22:06:39 INFO - "pgo_build": "False", 22:06:39 INFO - "basedir": "/builds/slave/test", 22:06:39 INFO - "project": "", 22:06:39 INFO - "platform": "ubuntu64_hw", 22:06:39 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 22:06:39 INFO - "slavebuilddir": "test", 22:06:39 INFO - "scheduler": "tests-fx-team-linux64-talos", 22:06:39 INFO - "branch": "fx-team", 22:06:39 INFO - "repo_path": "integration/fx-team", 22:06:39 INFO - "stage_platform": "linux64", 22:06:39 INFO - "builduid": "6712597707194299a0f43970d8439207", 22:06:39 INFO - "revision": "23eb26d374c6bb374cf7f2b23a77a7147f7a5371" 22:06:39 INFO - }, 22:06:39 INFO - "sourcestamp": { 22:06:39 INFO - "repository": "", 22:06:39 INFO - "hasPatch": false, 22:06:39 INFO - "project": "", 22:06:39 INFO - "branch": "fx-team-linux64-talos", 22:06:39 INFO - "changes": [ 22:06:39 INFO - { 22:06:39 INFO - "category": null, 22:06:39 INFO - "files": [ 22:06:39 INFO - { 22:06:39 INFO - "url": null, 22:06:39 INFO - "name": "https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:06:39 INFO - } 22:06:39 INFO - ], 22:06:39 INFO - "repository": "", 22:06:39 INFO - "rev": "23eb26d374c6bb374cf7f2b23a77a7147f7a5371", 22:06:39 INFO - "who": "philringnalda@gmail.com", 22:06:39 INFO - "when": 1448517945, 22:06:39 INFO - "number": 6709013, 22:06:39 INFO - "comments": "Back out 34c9087517ea (bug 1200798) for e10s bustage in browser_dbg_reload-same-script.js\nCLOSED TREE", 22:06:39 INFO - "project": "", 22:06:39 INFO - "at": "Wed 25 Nov 2015 22:05:45", 22:06:39 INFO - "branch": "fx-team-linux64-talos", 22:06:39 INFO - "revlink": "", 22:06:39 INFO - "properties": [ 22:06:39 INFO - [ 22:06:39 INFO - "buildid", 22:06:39 INFO - "20151125214012", 22:06:39 INFO - "Change" 22:06:39 INFO - ], 22:06:39 INFO - [ 22:06:39 INFO - "builduid", 22:06:39 INFO - "6712597707194299a0f43970d8439207", 22:06:39 INFO - "Change" 22:06:39 INFO - ], 22:06:39 INFO - [ 22:06:39 INFO - "pgo_build", 22:06:39 INFO - "False", 22:06:39 INFO - "Change" 22:06:39 INFO - ] 22:06:39 INFO - ], 22:06:39 INFO - "revision": "23eb26d374c6bb374cf7f2b23a77a7147f7a5371" 22:06:39 INFO - } 22:06:39 INFO - ], 22:06:39 INFO - "revision": "23eb26d374c6bb374cf7f2b23a77a7147f7a5371" 22:06:39 INFO - } 22:06:39 INFO - } 22:06:39 INFO - Found installer url https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:06:39 INFO - Running post-action listener: _resource_record_post_action 22:06:39 INFO - ##### 22:06:39 INFO - ##### Running download-and-extract step. 22:06:39 INFO - ##### 22:06:39 INFO - Running pre-action listener: _resource_record_pre_action 22:06:39 INFO - Running main action method: download_and_extract 22:06:39 INFO - mkdir: /builds/slave/test/build/tests 22:06:39 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')]} 22:06:39 INFO - https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:06:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/test_packages.json 22:06:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/test_packages.json 22:06:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:06:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:06:48 INFO - Downloaded 1302 bytes. 22:06:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:06:48 INFO - Using the following test package requirements: 22:06:48 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:06:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'jsshell-linux-x86_64.zip'], 22:06:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:06:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:06:48 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:06:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:06:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:06:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:06:48 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:06:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:06:48 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')]} 22:06:48 INFO - https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:06:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:06:55 INFO - Downloaded 21508487 bytes. 22:06:55 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:06:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:06:56 INFO - Return code: 0 22:06:56 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:06:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:56 INFO - https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:06:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:06:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:06:57 INFO - Downloaded 21508487 bytes. 22:06:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:06:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:06:57 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:06:58 INFO - Return code: 0 22:06:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:06:58 INFO - https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:06:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:06:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:06:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:07:00 INFO - Downloaded 11131717 bytes. 22:07:00 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 22:07:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:07:00 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 22:07:00 INFO - Return code: 0 22:07: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')]} 22:07:00 INFO - https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:07:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:07:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WP-bu1otRTiIh7NWxW-DmA/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 22:07:03 INFO - Downloaded 56846045 bytes. 22:07:03 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:03 INFO - mkdir: /builds/slave/test/properties 22:07:03 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:07:03 INFO - Writing to file /builds/slave/test/properties/build_url 22:07:03 INFO - Contents: 22:07:03 INFO - build_url:https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:07:03 INFO - Running post-action listener: _resource_record_post_action 22:07:03 INFO - Running post-action listener: set_extra_try_arguments 22:07:03 INFO - ##### 22:07:03 INFO - ##### Running populate-webroot step. 22:07:03 INFO - ##### 22:07:03 INFO - Running pre-action listener: _resource_record_pre_action 22:07:03 INFO - Running main action method: populate_webroot 22:07:03 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:07:03 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:07:03 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:07:03 INFO - '../fennec_ids.txt'], 22:07:03 INFO - 'tests': ['tcheck2']}, 22:07:03 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:07:03 INFO - '--tppagecycles', 22:07:03 INFO - '7'], 22:07:03 INFO - 'tests': ['tsvgm']}}, 22:07:03 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:07:03 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:07:03 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:03 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:07:03 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:03 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:07:03 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'tests': ['damp', 'tps']}, 22:07:03 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['damp', 'tps']}, 22:07:03 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:07:03 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:07:03 INFO - 'other': {'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'other_l64': {'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'other_nol64': {'tests': ['a11yr', 22:07:03 INFO - 'ts_paint', 22:07:03 INFO - 'tpaint', 22:07:03 INFO - 'sessionrestore', 22:07:03 INFO - 'sessionrestore_no_auto_restore']}, 22:07:03 INFO - 'svgr': {'tests': ['tsvgx', 22:07:03 INFO - 'tsvgr_opacity', 22:07:03 INFO - 'tart', 22:07:03 INFO - 'tscrollx', 22:07:03 INFO - 'cart']}, 22:07:03 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['tsvgx', 22:07:03 INFO - 'tsvgr_opacity', 22:07:03 INFO - 'tart', 22:07:03 INFO - 'tscrollx', 22:07:03 INFO - 'cart']}, 22:07:03 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'tests': ['tp5o']}, 22:07:03 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'talos_options': ['--e10s'], 22:07:03 INFO - 'tests': ['tp5o']}, 22:07:03 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'talos_options': ['--xperf_path', 22:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:03 INFO - 'tests': ['tp5n']}, 22:07:03 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:07:03 INFO - 'talos_options': ['--e10s', 22:07:03 INFO - '--xperf_path', 22:07:03 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:07:03 INFO - 'tests': ['tp5n']}}, 22:07:03 INFO - 'talos.zip': {'path': '', 22:07:03 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:07:03 INFO - Running post-action listener: _resource_record_post_action 22:07:03 INFO - ##### 22:07:03 INFO - ##### Running create-virtualenv step. 22:07:03 INFO - ##### 22:07:03 INFO - Running pre-action listener: _resource_record_pre_action 22:07:03 INFO - Running main action method: create_virtualenv 22:07:03 INFO - Creating virtualenv /builds/slave/test/build/venv 22:07:03 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 22:07:03 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:07:03 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:07:03 INFO - Using real prefix '/usr' 22:07:03 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:07:04 INFO - Installing distribute.............................................................................................................................................................................................done. 22:07:06 INFO - Installing pip.................done. 22:07:06 INFO - Return code: 0 22:07:06 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:07:06 INFO - Using env: {'DISPLAY': ':0', 22:07:06 INFO - 'HOME': '/home/cltbld', 22:07:06 INFO - 'LANG': 'en_US.UTF-8', 22:07:06 INFO - 'LANGUAGE': 'en_US:en', 22:07:06 INFO - 'LOGNAME': 'cltbld', 22:07:06 INFO - 'MAIL': '/var/mail/cltbld', 22:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:06 INFO - 'MOZ_NO_REMOTE': '1', 22:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:06 INFO - 'NO_EM_RESTART': '1', 22:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:06 INFO - 'PWD': '/builds/slave/test', 22:07:06 INFO - 'SHELL': '/bin/bash', 22:07:06 INFO - 'SHLVL': '1', 22:07:06 INFO - 'TERM': 'linux', 22:07:06 INFO - 'TMOUT': '86400', 22:07:06 INFO - 'USER': 'cltbld', 22:07:06 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:06 INFO - '_': '/tools/buildbot/bin/python'} 22:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:06 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 22:07:06 INFO - Cleaning up... 22:07:06 INFO - Return code: 0 22:07:06 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:06 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:06 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:07:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:07:06 INFO - Using env: {'DISPLAY': ':0', 22:07:06 INFO - 'HOME': '/home/cltbld', 22:07:06 INFO - 'LANG': 'en_US.UTF-8', 22:07:06 INFO - 'LANGUAGE': 'en_US:en', 22:07:06 INFO - 'LOGNAME': 'cltbld', 22:07:06 INFO - 'MAIL': '/var/mail/cltbld', 22:07:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:06 INFO - 'MOZ_NO_REMOTE': '1', 22:07:06 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:06 INFO - 'NO_EM_RESTART': '1', 22:07:06 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:06 INFO - 'PWD': '/builds/slave/test', 22:07:06 INFO - 'SHELL': '/bin/bash', 22:07:06 INFO - 'SHLVL': '1', 22:07:06 INFO - 'TERM': 'linux', 22:07:06 INFO - 'TMOUT': '86400', 22:07:06 INFO - 'USER': 'cltbld', 22:07:06 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:06 INFO - '_': '/tools/buildbot/bin/python'} 22:07:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:06 INFO - Downloading/unpacking psutil>=0.7.1 22:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:07:08 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:07:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:07:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:08 INFO - Installing collected packages: psutil 22:07:08 INFO - Running setup.py install for psutil 22:07:08 INFO - building 'psutil._psutil_linux' extension 22:07:08 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 22:07:08 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 22:07:08 INFO - building 'psutil._psutil_posix' extension 22:07:08 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 22:07:08 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 22:07:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:07:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:07:09 INFO - Successfully installed psutil 22:07:09 INFO - Cleaning up... 22:07:09 INFO - Return code: 0 22:07:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:07:09 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')]} 22:07:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:09 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')]} 22:07:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:09 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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:09 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 22:07:09 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 22:07:09 INFO - Using env: {'DISPLAY': ':0', 22:07:09 INFO - 'HOME': '/home/cltbld', 22:07:09 INFO - 'LANG': 'en_US.UTF-8', 22:07:09 INFO - 'LANGUAGE': 'en_US:en', 22:07:09 INFO - 'LOGNAME': 'cltbld', 22:07:09 INFO - 'MAIL': '/var/mail/cltbld', 22:07:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:09 INFO - 'MOZ_NO_REMOTE': '1', 22:07:09 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:09 INFO - 'NO_EM_RESTART': '1', 22:07:09 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:09 INFO - 'PWD': '/builds/slave/test', 22:07:09 INFO - 'SHELL': '/bin/bash', 22:07:09 INFO - 'SHLVL': '1', 22:07:09 INFO - 'TERM': 'linux', 22:07:09 INFO - 'TMOUT': '86400', 22:07:09 INFO - 'USER': 'cltbld', 22:07:09 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:09 INFO - '_': '/tools/buildbot/bin/python'} 22:07:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:07:09 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 22:07:09 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 22:07:09 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 22:07:09 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 22:07:09 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 22:07:09 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 22:07:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:07:11 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:07:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:07:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:07:11 INFO - Installing collected packages: mozsystemmonitor 22:07:11 INFO - Running setup.py install for mozsystemmonitor 22:07:11 INFO - Successfully installed mozsystemmonitor 22:07:11 INFO - Cleaning up... 22:07:11 INFO - Return code: 0 22:07:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:07: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')]} 22:07:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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')]} 22:07:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07: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', '--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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:11 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 22:07:11 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 22:07:11 INFO - Using env: {'DISPLAY': ':0', 22:07:11 INFO - 'HOME': '/home/cltbld', 22:07:11 INFO - 'LANG': 'en_US.UTF-8', 22:07:11 INFO - 'LANGUAGE': 'en_US:en', 22:07:11 INFO - 'LOGNAME': 'cltbld', 22:07:11 INFO - 'MAIL': '/var/mail/cltbld', 22:07:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:11 INFO - 'MOZ_NO_REMOTE': '1', 22:07:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:11 INFO - 'NO_EM_RESTART': '1', 22:07:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:11 INFO - 'PWD': '/builds/slave/test', 22:07:11 INFO - 'SHELL': '/bin/bash', 22:07:11 INFO - 'SHLVL': '1', 22:07:11 INFO - 'TERM': 'linux', 22:07:11 INFO - 'TMOUT': '86400', 22:07:11 INFO - 'USER': 'cltbld', 22:07:11 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:11 INFO - '_': '/tools/buildbot/bin/python'} 22:07:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:11 INFO - Downloading/unpacking blobuploader==1.2.4 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:11 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 22:07:13 INFO - Downloading blobuploader-1.2.4.tar.gz 22:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:07:13 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:07:13 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 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 22:07:13 INFO - Downloading docopt-0.6.1.tar.gz 22:07:13 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:07:13 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:07:13 INFO - Installing collected packages: blobuploader, requests, docopt 22:07:13 INFO - Running setup.py install for blobuploader 22:07:13 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:07:13 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:07:13 INFO - Running setup.py install for requests 22:07:14 INFO - Running setup.py install for docopt 22:07:14 INFO - Successfully installed blobuploader requests docopt 22:07:14 INFO - Cleaning up... 22:07:14 INFO - Return code: 0 22:07:14 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:14 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')]} 22:07:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:14 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')]} 22:07:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:14 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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:14 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 22:07:14 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 22:07:14 INFO - Using env: {'DISPLAY': ':0', 22:07:14 INFO - 'HOME': '/home/cltbld', 22:07:14 INFO - 'LANG': 'en_US.UTF-8', 22:07:14 INFO - 'LANGUAGE': 'en_US:en', 22:07:14 INFO - 'LOGNAME': 'cltbld', 22:07:14 INFO - 'MAIL': '/var/mail/cltbld', 22:07:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:14 INFO - 'MOZ_NO_REMOTE': '1', 22:07:14 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:14 INFO - 'NO_EM_RESTART': '1', 22:07:14 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:14 INFO - 'PWD': '/builds/slave/test', 22:07:14 INFO - 'SHELL': '/bin/bash', 22:07:14 INFO - 'SHLVL': '1', 22:07:14 INFO - 'TERM': 'linux', 22:07:14 INFO - 'TMOUT': '86400', 22:07:14 INFO - 'USER': 'cltbld', 22:07:14 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:14 INFO - '_': '/tools/buildbot/bin/python'} 22:07:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:14 INFO - Running setup.py (path:/tmp/pip-YReGp8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:14 INFO - Running setup.py (path:/tmp/pip-1FH6I8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:14 INFO - Running setup.py (path:/tmp/pip-1sUmAE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:14 INFO - Running setup.py (path:/tmp/pip-qulSCy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:14 INFO - Running setup.py (path:/tmp/pip-sHjpbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:15 INFO - Running setup.py (path:/tmp/pip-dOTXE6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:15 INFO - Running setup.py (path:/tmp/pip-OwhMv1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:15 INFO - Running setup.py (path:/tmp/pip-tbzMjr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:15 INFO - Running setup.py (path:/tmp/pip-5sHnWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:15 INFO - Running setup.py (path:/tmp/pip-zyd__J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:15 INFO - Running setup.py (path:/tmp/pip-IZzxhI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:15 INFO - Running setup.py (path:/tmp/pip-JDMBz3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:15 INFO - Running setup.py (path:/tmp/pip-Z6qLMn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:15 INFO - Running setup.py (path:/tmp/pip-kqn6sl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:15 INFO - Running setup.py (path:/tmp/pip-VPd9xo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:15 INFO - Running setup.py (path:/tmp/pip-HAREVa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:15 INFO - Running setup.py (path:/tmp/pip-o20W2O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:15 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:07:15 INFO - Running setup.py install for manifestparser 22:07:15 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:07:15 INFO - Running setup.py install for mozcrash 22:07:16 INFO - Running setup.py install for mozdebug 22:07:16 INFO - Running setup.py install for mozdevice 22:07:16 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for mozfile 22:07:16 INFO - Running setup.py install for mozhttpd 22:07:16 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for mozinfo 22:07:16 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for mozInstall 22:07:16 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for mozleak 22:07:16 INFO - Running setup.py install for mozlog 22:07:16 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for moznetwork 22:07:16 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:07:16 INFO - Running setup.py install for mozprocess 22:07:17 INFO - Running setup.py install for mozprofile 22:07:17 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Running setup.py install for mozrunner 22:07:17 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Running setup.py install for mozscreenshot 22:07:17 INFO - Running setup.py install for moztest 22:07:17 INFO - Running setup.py install for mozversion 22:07:17 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:07:17 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:07:17 INFO - Cleaning up... 22:07:17 INFO - Return code: 0 22:07:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:17 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')]} 22:07:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:17 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')]} 22:07:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:17 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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:17 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 22:07:17 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 22:07:17 INFO - Using env: {'DISPLAY': ':0', 22:07:17 INFO - 'HOME': '/home/cltbld', 22:07:17 INFO - 'LANG': 'en_US.UTF-8', 22:07:17 INFO - 'LANGUAGE': 'en_US:en', 22:07:17 INFO - 'LOGNAME': 'cltbld', 22:07:17 INFO - 'MAIL': '/var/mail/cltbld', 22:07:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:17 INFO - 'MOZ_NO_REMOTE': '1', 22:07:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:17 INFO - 'NO_EM_RESTART': '1', 22:07:17 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:17 INFO - 'PWD': '/builds/slave/test', 22:07:17 INFO - 'SHELL': '/bin/bash', 22:07:17 INFO - 'SHLVL': '1', 22:07:17 INFO - 'TERM': 'linux', 22:07:17 INFO - 'TMOUT': '86400', 22:07:17 INFO - 'USER': 'cltbld', 22:07:17 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:17 INFO - '_': '/tools/buildbot/bin/python'} 22:07:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:07:17 INFO - Running setup.py (path:/tmp/pip-GzzFfe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:07:17 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)) 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:07:17 INFO - Running setup.py (path:/tmp/pip-vV99Bu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:07:17 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)) 22:07:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:07:17 INFO - Running setup.py (path:/tmp/pip-FBZIG2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:07:18 INFO - Running setup.py (path:/tmp/pip-Empz9x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:07:18 INFO - Running setup.py (path:/tmp/pip-H6oJNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:07:18 INFO - Running setup.py (path:/tmp/pip-ZQ3RDY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:07:18 INFO - Running setup.py (path:/tmp/pip-CuWFXE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:07:18 INFO - Running setup.py (path:/tmp/pip-O6gzvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:07:18 INFO - Running setup.py (path:/tmp/pip-pLU0Uk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:07:18 INFO - Running setup.py (path:/tmp/pip-yC5f04-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:07:18 INFO - Running setup.py (path:/tmp/pip-YxNh6s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:07:18 INFO - Running setup.py (path:/tmp/pip-9eofZZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:07:18 INFO - Running setup.py (path:/tmp/pip-cHCpSe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:07:18 INFO - Running setup.py (path:/tmp/pip-udhDFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:18 INFO - Running setup.py (path:/tmp/pip-XX392n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:07:18 INFO - Running setup.py (path:/tmp/pip-_Q8BrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:07:18 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)) 22:07:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:07:19 INFO - Running setup.py (path:/tmp/pip-vwoadm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:07:19 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)) 22:07:19 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)) 22:07:19 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)) 22:07:19 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)) 22:07:19 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)) 22:07:19 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)) 22:07:19 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:07:19 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 22:07:19 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 22:07:19 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 22:07:19 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 22:07:19 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 22:07:19 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 22:07:20 INFO - Downloading blessings-1.5.1.tar.gz 22:07:20 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 22:07:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:07:20 INFO - Installing collected packages: blessings 22:07:20 INFO - Running setup.py install for blessings 22:07:20 INFO - Successfully installed blessings 22:07:20 INFO - Cleaning up... 22:07:21 INFO - Return code: 0 22:07:21 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:07:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:21 INFO - Reading from file tmpfile_stdout 22:07:21 INFO - Current package versions: 22:07:21 INFO - argparse == 1.2.1 22:07:21 INFO - blessings == 1.5.1 22:07:21 INFO - blobuploader == 1.2.4 22:07:21 INFO - docopt == 0.6.1 22:07:21 INFO - manifestparser == 1.1 22:07:21 INFO - mozInstall == 1.12 22:07:21 INFO - mozcrash == 0.16 22:07:21 INFO - mozdebug == 0.1 22:07:21 INFO - mozdevice == 0.47 22:07:21 INFO - mozfile == 1.2 22:07:21 INFO - mozhttpd == 0.7 22:07:21 INFO - mozinfo == 0.9 22:07:21 INFO - mozleak == 0.1 22:07:21 INFO - mozlog == 3.1 22:07:21 INFO - moznetwork == 0.27 22:07:21 INFO - mozprocess == 0.22 22:07:21 INFO - mozprofile == 0.27 22:07:21 INFO - mozrunner == 6.11 22:07:21 INFO - mozscreenshot == 0.1 22:07:21 INFO - mozsystemmonitor == 0.0 22:07:21 INFO - moztest == 0.7 22:07:21 INFO - mozversion == 1.4 22:07:21 INFO - psutil == 3.1.1 22:07:21 INFO - requests == 1.2.3 22:07:21 INFO - wsgiref == 0.1.2 22:07:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:21 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 22:07:21 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 22:07:21 INFO - Using env: {'DISPLAY': ':0', 22:07:21 INFO - 'HOME': '/home/cltbld', 22:07:21 INFO - 'LANG': 'en_US.UTF-8', 22:07:21 INFO - 'LANGUAGE': 'en_US:en', 22:07:21 INFO - 'LOGNAME': 'cltbld', 22:07:21 INFO - 'MAIL': '/var/mail/cltbld', 22:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:21 INFO - 'MOZ_NO_REMOTE': '1', 22:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:21 INFO - 'NO_EM_RESTART': '1', 22:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:21 INFO - 'PWD': '/builds/slave/test', 22:07:21 INFO - 'SHELL': '/bin/bash', 22:07:21 INFO - 'SHLVL': '1', 22:07:21 INFO - 'TERM': 'linux', 22:07:21 INFO - 'TMOUT': '86400', 22:07:21 INFO - 'USER': 'cltbld', 22:07:21 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:21 INFO - '_': '/tools/buildbot/bin/python'} 22:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 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)) 22:07:21 INFO - Cleaning up... 22:07:21 INFO - Return code: 0 22:07:21 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 22:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:07:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:07:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:07:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1334030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14938a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1561550>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, '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': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', '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 22:07:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 22:07:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 22:07:21 INFO - Using env: {'DISPLAY': ':0', 22:07:21 INFO - 'HOME': '/home/cltbld', 22:07:21 INFO - 'LANG': 'en_US.UTF-8', 22:07:21 INFO - 'LANGUAGE': 'en_US:en', 22:07:21 INFO - 'LOGNAME': 'cltbld', 22:07:21 INFO - 'MAIL': '/var/mail/cltbld', 22:07:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:21 INFO - 'MOZ_NO_REMOTE': '1', 22:07:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:21 INFO - 'NO_EM_RESTART': '1', 22:07:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:21 INFO - 'PWD': '/builds/slave/test', 22:07:21 INFO - 'SHELL': '/bin/bash', 22:07:21 INFO - 'SHLVL': '1', 22:07:21 INFO - 'TERM': 'linux', 22:07:21 INFO - 'TMOUT': '86400', 22:07:21 INFO - 'USER': 'cltbld', 22:07:21 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:21 INFO - '_': '/tools/buildbot/bin/python'} 22:07:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:07:21 INFO - Downloading/unpacking jsonschema 22:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 22:07:23 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 22:07:23 INFO - Downloading/unpacking functools32 (from jsonschema) 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:07:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:07:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:07:23 INFO - Downloading functools32-3.2.3-2.tar.gz 22:07:23 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 22:07:23 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 22:07:23 INFO - warning: no files found matching '*.txt' 22:07:23 INFO - no previously-included directories found matching 'build' 22:07:23 INFO - no previously-included directories found matching 'dist' 22:07:23 INFO - no previously-included directories found matching '.git*' 22:07:23 INFO - Installing collected packages: jsonschema, functools32 22:07:23 INFO - Running setup.py install for functools32 22:07:23 INFO - warning: no files found matching '*.txt' 22:07:23 INFO - no previously-included directories found matching 'build' 22:07:23 INFO - no previously-included directories found matching 'dist' 22:07:23 INFO - no previously-included directories found matching '.git*' 22:07:23 INFO - Successfully installed jsonschema functools32 22:07:23 INFO - Cleaning up... 22:07:23 INFO - Return code: 0 22:07:23 INFO - Running post-action listener: _resource_record_post_action 22:07:23 INFO - Running post-action listener: _start_resource_monitoring 22:07:23 INFO - Starting resource monitoring. 22:07:23 INFO - ##### 22:07:23 INFO - ##### Running install step. 22:07:23 INFO - ##### 22:07:23 INFO - Running pre-action listener: _resource_record_pre_action 22:07:23 INFO - Running main action method: install 22:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:07:23 INFO - Reading from file tmpfile_stdout 22:07:23 INFO - Detecting whether we're running mozinstall >=1.0... 22:07:23 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:07:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:07:24 INFO - Reading from file tmpfile_stdout 22:07:24 INFO - Output received: 22:07:24 INFO - Usage: mozinstall [options] installer 22:07:24 INFO - Options: 22:07:24 INFO - -h, --help show this help message and exit 22:07:24 INFO - -d DEST, --destination=DEST 22:07:24 INFO - Directory to install application into. [default: 22:07:24 INFO - "/builds/slave/test"] 22:07:24 INFO - --app=APP Application being installed. [default: firefox] 22:07:24 INFO - mkdir: /builds/slave/test/build/application 22:07:24 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:07:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:07:38 INFO - Reading from file tmpfile_stdout 22:07:38 INFO - Output received: 22:07:38 INFO - /builds/slave/test/build/application/firefox/firefox 22:07:38 INFO - Running post-action listener: _resource_record_post_action 22:07:38 INFO - ##### 22:07:38 INFO - ##### Running run-tests step. 22:07:38 INFO - ##### 22:07:38 INFO - Running pre-action listener: _resource_record_pre_action 22:07:38 INFO - Running main action method: run_tests 22:07:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:07:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:07:38 INFO - Python 2.7.3 22:07:38 INFO - Return code: 0 22:07:38 INFO - grabbing minidump binary from tooltool 22:07:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:07:38 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x15f07a0>, '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 0x15f16a0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x15f1b50>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:07:38 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:07:38 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:07:38 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:07:38 INFO - Return code: 0 22:07:38 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:07:38 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:07:38 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:07:38 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:07:38 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:07:38 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] in /builds/slave/test/build 22:07:38 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-e10s --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-008 --webServer localhost 22:07:38 INFO - Using env: {'DISPLAY': ':0', 22:07:38 INFO - 'HOME': '/home/cltbld', 22:07:38 INFO - 'LANG': 'en_US.UTF-8', 22:07:38 INFO - 'LANGUAGE': 'en_US:en', 22:07:38 INFO - 'LOGNAME': 'cltbld', 22:07:38 INFO - 'MAIL': '/var/mail/cltbld', 22:07:38 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:07:38 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:07:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:07:38 INFO - 'MOZ_NO_REMOTE': '1', 22:07:38 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:07:38 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:07:38 INFO - 'NO_EM_RESTART': '1', 22:07:38 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:07:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:07:38 INFO - 'PWD': '/builds/slave/test', 22:07:38 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:07:38 INFO - 'SHELL': '/bin/bash', 22:07:38 INFO - 'SHLVL': '1', 22:07:38 INFO - 'TERM': 'linux', 22:07:38 INFO - 'TMOUT': '86400', 22:07:38 INFO - 'USER': 'cltbld', 22:07:38 INFO - 'XDG_SESSION_COOKIE': '7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322', 22:07:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:07:38 INFO - '_': '/tools/buildbot/bin/python'} 22:07:38 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-e10s', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-008', '--webServer', 'localhost'] with output_timeout 3600 22:07:38 INFO - mozversion INFO | application_buildid: 20151125214012 22:07:38 INFO - mozversion INFO | application_changeset: 23eb26d374c6bb374cf7f2b23a77a7147f7a5371 22:07:38 INFO - mozversion INFO | application_display_name: Nightly 22:07:38 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:07:38 INFO - mozversion INFO | application_name: Firefox 22:07:38 INFO - mozversion INFO | application_remotingname: firefox 22:07:38 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 22:07:38 INFO - mozversion INFO | application_vendor: Mozilla 22:07:38 INFO - mozversion INFO | application_version: 45.0a1 22:07:38 INFO - mozversion INFO | platform_buildid: 20151125214012 22:07:38 INFO - mozversion INFO | platform_changeset: 23eb26d374c6bb374cf7f2b23a77a7147f7a5371 22:07:38 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 22:07:38 INFO - mozversion INFO | platform_version: 45.0a1 22:07:38 INFO - 2015-11-25 22:07:38,637 DEBUG : using testdate: 1448518058 22:07:38 INFO - 2015-11-25 22:07:38,637 DEBUG : actual date: 1448518058 22:07:38 INFO - 2015-11-25 22:07:38,646 INFO : starting webserver on 'localhost:49931' 22:07:38 INFO - 2015-11-25 22:07:38,647 INFO : Starting test suite talos-linux64-ix-008.e 22:07:38 INFO - 2015-11-25 22:07:38,647 INFO : Starting test dromaeo_css 22:07:38 INFO - 2015-11-25 22:07:38,647 DEBUG : operating with platform_type : linux_ 22:07:38 INFO - 2015-11-25 22:07:38,648 INFO : Initialising browser for dromaeo_css test... 22:07:38 INFO - 2015-11-25 22:07:38,664 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprGOnQk/profile http://localhost:49931/getInfo.html 22:07:43 INFO - 2015-11-25 22:07:43,774 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:07:43 INFO - 2015-11-25 22:07:43,774 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:07:43 INFO - 2015-11-25 22:07:43,774 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:07:43 INFO - 2015-11-25 22:07:43,774 DEBUG : BROWSER_OUTPUT: __metrics 22:07:44 INFO - 2015-11-25 22:07:44,836 INFO : Browser initialized. 22:07:44 INFO - 2015-11-25 22:07:44,837 INFO : Running cycle 1/1 for dromaeo_css test... 22:07:44 INFO - 2015-11-25 22:07:44,837 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmprGOnQk/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:07:56 INFO - 2015-11-25 22:07:56,753 DEBUG : BROWSER_OUTPUT: RSS: Main: 137736192 22:07:56 INFO - 2015-11-25 22:07:56,753 DEBUG : BROWSER_OUTPUT: 22:08:46 INFO - 2015-11-25 22:08:46,406 DEBUG : BROWSER_OUTPUT: 1448518126404 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] 22:10:57 INFO - 2015-11-25 22:10:57,642 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49931/tests/dromaeo/cssquery-ext.html) 22:10:58 INFO - 2015-11-25 22:10:58,786 DEBUG : BROWSER_OUTPUT: RSS: Main: 144969728 22:10:58 INFO - 2015-11-25 22:10:58,787 DEBUG : BROWSER_OUTPUT: 22:14:00 INFO - 2015-11-25 22:14:00,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-ext.html (next: http://localhost:49931/tests/dromaeo/cssquery-jquery.html) 22:14:01 INFO - 2015-11-25 22:14:01,307 DEBUG : BROWSER_OUTPUT: RSS: Main: 144637952 22:14:01 INFO - 2015-11-25 22:14:01,307 DEBUG : BROWSER_OUTPUT: 22:17:02 INFO - 2015-11-25 22:17:02,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49931/tests/dromaeo/cssquery-mootools.html) 22:17:03 INFO - 2015-11-25 22:17:03,591 DEBUG : BROWSER_OUTPUT: RSS: Main: 143556608 22:17:03 INFO - 2015-11-25 22:17:03,591 DEBUG : BROWSER_OUTPUT: 22:20:05 INFO - 2015-11-25 22:20:05,299 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49931/tests/dromaeo/cssquery-prototype.html) 22:20:05 INFO - 2015-11-25 22:20:05,909 DEBUG : BROWSER_OUTPUT: RSS: Main: 140312576 22:20:05 INFO - 2015-11-25 22:20:05,909 DEBUG : BROWSER_OUTPUT: 22:23:08 INFO - 2015-11-25 22:23:08,529 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49931/tests/dromaeo/cssquery-yui.html) 22:23:09 INFO - 2015-11-25 22:23:09,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 142753792 22:23:09 INFO - 2015-11-25 22:23:09,156 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,381 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/dromaeo/cssquery-yui.html (next: http://localhost:49931/tests/dromaeo/cssquery-dojo.html) 22:26:11 INFO - 2015-11-25 22:26:11,639 DEBUG : BROWSER_OUTPUT: RSS: Main: 145182720 22:26:11 INFO - 2015-11-25 22:26:11,639 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,639 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2666.5466870631994;2668.2795645175793;2700.594910763385;2713.3216695826045;2732.685741139769;4481.529439408864;4600.884977875555;4654.0924519718665;4669.976650116753;4756.476787553366;4568.360429539867;4592.701474404162;4628.90742185157;4639.7912093955765;4698.718076915387;4079.530853951789;4343.93484097738;4346.4349634547625;4400.163968845925;4411.228035093862;4070.5522392536795;4328.437303150586;4341.02326976431;4373.606375426211;4418.513963464016;4185.66514678828;4186.6022727840655;4197.999999999969;4212.115455754265;4299.742015479082;4301.376300436419;4302.5052119006405;4319.913601727979;4328.826846926151;4349.7825108744755;4288.635465985395;4294.849680261176;4301.268784306675;4308.310670292738;4355.84754533593;4412.823487060514;4415.602595766364;4537.682362234645;4551.226291530448;4558.49856515783;4942.604591632661;5038.067957427887;5046.09170349337;5049.899002019975;5092.643514953955;4763.499832517605;5042.672226305279;5070.974645126787;5071.416787069497;5120.1039818031695;4548.795304211285;4597.632189424871;4607.7004994675235;4619.030003699261;4647.790849411717;5163.870903227449;5173.301604283449;5207.505286997729;5209.036328279205;5265.710385928811;4677.672562920563;4783.832565860248;4976.552110310089;4984.6261530384645;5037.093323201859;4905.901881962341;4960.379952505937;4980.950190498121;4989.700617962933;5034.899302014012;4918.385201849769;5009.073321435546;5011.448740638527;5026.019926114445;5039.118154323052;4717.174494463524;4828.444728856156;4832;4951.529604687549;5018.974905125451;4185.3931179979345;4187.078842654611;4192.853250136231;4215.852445164466;4230.407742915994;3673.7979411132646;3675.963240367562;3710.8330125144435;3714.1271801126713;3741.607131251234;4080.0411903202726;4195.454590903163;4197.118605092965;4197.454330936958;4368.213721530155;4969.18008528596;5007.574356179693;5016.423111342242;5021.271915572222;5038.874028149326;4348.652107831366;4356.738595684269;4359.149965756647;4386.1008493258805;4386.758728269912;4217.91564168721;4306.461692288464;4376;4426.490953540384;4483.529229430863;4724.480307166277;4727.976360118246;4731.077439899186;4759.262314341283;4780.808767649255;4975.253711943237;5005.249212618136;5007.7245751484015;5007.874803129951;5057.848264552069;4565.863024109282;4639.048994955959;4698.412698412699;4729.148753224453;4753.643476739189;4884.90230195387;4911.852644420673;4917.827876024322;4930.457649658463;4971.477994810638;4990.3762029746285;4990.775415106256;4997.525235102659;5005.199168133081;5066.392032956069;4579.564941330568;4687.36720542736;4697.906041879211;4750.952490475051;4862.978774457403;4815.109204797123;4816.133096042746;4829.058333624909;4831.492693267156;4879.829205977774;4703.129920964632;4742.596879265163;4748.4776674566465;4753.239481682914;4778.187708089564;4609.101225261042;4732.077244937204;4788.209945359116;4885.267209918541;4919.1883339248625;4748.691335063209;4811;4839.128956787812;4840.1529732296;4864.708117512961 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |1;ext.html;494.4091810286709;494.49561447323754;566.7251383079206;568.573569822633;569.2798609758656;31538.211544711365;31907.68092319079;31953;32111.51832722511;32128.196795080075;40233.798831005806;40812.38781418281;40814.79592602033;40842.38736418956;40889.795551022275;7904.249096335839;8122.309603683664;8173.836523269531;8180.9590952045455;8188.467749596287;7789.3768498519985;7898.368130549542;7943.24539168778;7957.602119894011;7974.401919856005;7993.520388776663;8049.839003219932;8113.823495593165;8116.553589552572;8135.959320203391;7977.760667179994;7987.880181797278;8018.799530011738;8036.397270204758;8043.436959412844;7900.486468379537;8049.758507244792;8051.476654017529;8079.394045446556;8088.636011379502;37419.25161496782;37791.811040944616;38074.61925380738;38086;38239.4264086039;2651.814372993891;2659.228823641142;2793.8742756576003;3028.5457181422744;3076.769242306836;28062.859685701646;28272.15183544497;28495.430091398262;28579.714202857915;28707.71292287092;3384.4077286474767;3460.5501284832812;3505.2288496530723;3529.6999755020597;3577.3560759063357;327328;329966;331874;332091;332353;37627.43558846619;37925.24149516994;37944.43083353752;54634;55613.443865560825;36883.63116368856;36889.44665830015;36963.4455483168;37134.628653713655;37196.628033719855;11256.943715281535;11345.09239260857;11365.431728413547;11385.430728463543;11419.086473082134;9080.40977336471;9171.403858749294;9201.815963680689;9230.58462369195;9238;13320.400581973834;13408.128471649312;13409.530666426823;13454.93272533631;13465.259410732504;4641.86074417768;4663.114008338405;4729.101470720552;4790.640701947298;4813.831515896927;842.8440738463404;855.2644725536034;920.8848893888264;939.9248060155171;993.4684943555163;26299.605505917425;26463.206103816916;29435.705642943296;29692.406151877272;30619.38761224763;883.902770695223;894.7136916186757;957.008975058258;970.6651205334149;1015.7968406318765;12828.03789715775;12944.741105177844;13019.283939383426;13040.608781736562;13044.413001414769;316090;317762;320890;321098;321743;46809;47107.764461177474;47117.76441117841;47242;47414;1185.6739396665814;1186.5135294529202;1192.9455433261587;1198.3349241171234;1201.8077107662557;25397.61903571411;25609.23172304834;26009.73990260149;26169;26259;38573.614263857;38906.6109338903;39104.2179156421;39254.80372598233;39597.2080558393;248002;248450;248675;249047;249584;29627.259318517208;37801.432978504796;38131.80934095312;38222.42666360062;38718.41922371223;39478.60521394864;39527;39718.60281397265;40013.59986400215;40308.798456007535;33778.32443351168;33966.83016584901;34029.31941361209;34098.659013409546;34929.47605785864;33768.49347259744;33957.151071222426;34091.488627671104;34205.48691769576;34237.315253695284;33214.501782473766;33788;33821;34041;34081;29553.85223073957;30652.540211896394;31124;31498.68501315049;31622.683773161974;21832.23587174441;22007.11971521121;22170.452727563512;22185.889070554545;22221.22225722092 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |2;jquery.html;332.9151066478049;336.9022983334833;337.5308321433208;337.9577552805901;339.42806371264413;15185.848141518582;15255.923720381397;15961.201939902987;16472.670546589063;16794.24425900836;9613.759656008604;9825.508724563779;12200.145989780718;13881.514147004857;13929.512467063654;4683.718976861391;4803.183458811993;4805.687630304019;4813.90372192556;5099.617528685363;5103.23451482277;5125.974370128144;5126.154184559543;5162.1224391853475;5164.277001219813;4940.678855874375;5086.389633244016;5097.464766199551;5158.9742051289695;5173.456787037363;4864.391951006124;5075.289459475676;5109.463506331819;5116.565091967169;5147.562457191143;4836.879078023042;4844.103840789465;4846.563809257149;4846.927296090562;4850.927236091461;11539;19125.521861953424;19147.61704765897;19402;19667.213311467523;1792.1845560270046;1799.5770993816443;1839.383806424836;1847.5288801355703;1890.395073576456;9038.593263303168;9053.547322633907;9169.128932751379;9330.580123894373;10587.84118238227;1578.7552929295978;1649.4144578674639;1728.3605066125615;1767.1517671517743;1776.9733453998201;54023.45976540224;56148.71925640386;57282.713586431804;57530.1370479439;57734.42265577374;9573;9754.488054351586;9855.408675479493;9900.900990990142;9955.651552195783;12399.566015189424;12468.688282793002;12549.372531373394;12549.811752823714;12575.811362829565;6538.084668146464;6778;6938.514303998772;6984.2317345092;7020.087388639444;6729.327067293231;6738.19141702989;6742.8651426972165;6801.4898882584;6803.251642319341;4182.749035057906;4244.2996905510245;4255.404243405926;4258.1057977824385;4258.957410425918;1515.3635473101324;1756.8682348823888;1776.538100093985;1783.4293026231742;1815.2738904438065;730.3135053050116;765.4068097224696;823.9546824924566;898.1826537850525;967.9854802177973;15361.539153825403;15447.227638618024;15451.690966180613;16044.919775401047;16060;761.5582961882095;822.4448497264323;830.8462934357163;840.815020695446;913.5340976102236;8158.959205203936;8240.423170378015;8442.155784421631;8627.22354988054;9242.12199841014;452533;459426;460020;460246.5778079922;468137;70128;70603.2939670607;71968;72784.27215727881;72962;1023.9846402303972;1028.9125424339015;1037.911777498921;1038.4496217004998;1039.2569312941284;14211.786823197866;14291.142531448146;14322.713545729235;14380.640483987983;14430.567082987527;32548.349033018734;32820.343593128484;32854.507182391804;34047.48928766021;34107.82946085254;44339.55660443483;45900.31149532693;46162.307565387215;46493.302600460345;47272;8884;9107.863382049407;9280.907190928005;9294.395864268801;9299.76750581241;15990.360385584447;16066;16117.516474505315;16227;16372.83627163713;12684.556040538537;13127.474901003852;13366.398512066786;13442;13715.862841371458;13150.868491314965;13415.865841341853;13821.516246931309;14133.081349712236;14209.360578773772;12791;12933.805992909925;12952;13003.08978371505;13161.736765264832;8723.345749068973;9009.23421509179;9053.90946090557;9092.363534552518;9229.261659067393;12737.681557961125;13140.60578182656;13215.207087574776;13340.665383557645;14001.649958751113 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1347.7035052288493;1352.4387379237617;1397.133777058224;1565.7651352297155;1633.6405990682053;6709.396154346108;7049.682764275607;7070.292970702927;7097.396721278685;7162.176349719777;6985.441164706824;6997.3002699730005;7043.084399028119;7047.964760176204;7061.858762824753;2040.8469364797663;2066.1735305877696;2068.338131797825;2082.2816128435666;2085.8852763098025;2069.6791997240452;2075.501879548905;2094.3298144593737;2114.3762590035976;2115.3336698939784;2023.9797602024012;2069.3998740365278;2069.896505174735;2081.5212501124674;2089.456741247279;2026.0983862181336;2045.3966080006435;2048.846336524759;2049.764277108137;2050.8769473831544;2064.370367038053;2100.306898723418;2103.758067822205;2106.315447479575;2112.9894350528302;6822.215445223764;6889.311068893121;6931.549449285781;6937.583744975318;6964.756233531853;3937.8818635440985;3982.880513584597;3995.5005624296964;4000.5199376075057;4004.6796256299426;2730.8634568271705;2736.7263273672675;2805.5230610796216;2823.8446885421295;2828.8161269517414;836.2390224895377;837.7151768398774;840.2941529115511;846.1622993236651;877.2630989968458;9195;9206.677766278215;9234.307426943005;9258.95370523143;9266.16604505591;3614.710823134143;3667.504886840296;3700.5559332880225;3775.2638235543805;3778.4899038629983;7515.549067055994;7584.2794934481135;7586.203448637924;7596.582187979604;7623.656935437919;3960.5841386653988;3969.900752481211;3974.0859602291057;3975.045988962686;3976.76139431635;3573.4103872861206;3614.8373323200517;3615.801130937771;3631.3463576556474;3637.181634132299;2979.865906034234;3017.336186039068;3047.7104675055834;3049.60355153833;3075.7539396848197;922.9261659067258;926.5598840550684;931.106138107411;931.464407965409;934.5514153206364;664.4551467796457;665.4244078871741;669.0733334331888;669.4744625468984;751.8984687432937;6132.6627035513475;6482.189726284215;6484.286728459866;6501.642409667419;6514.739410423625;852.9656768606793;867.3754896474528;867.6832955971025;924.1867156902018;1003.2525768302661;5049.722265275372;5075;5111.46329635383;5121.334226550524;5137.33214682089;8249.422540422112;8348.081711011784;8490.957545212234;8556.657733690707;8614.440061396115;8402.285805706584;8416.915830841614;8458.915410845813;8460.280876125475;8491.702790402307;6091.66495842724;6170.907436388457;6238.157848690369;6252.937470625327;6288.999999999908;5810.564207684356;5854.560907931837;5866.6480011199465;5882.176495290748;5890.410958904075;7164.749233776793;7256.96371518139;7353.852922941618;7408.333250007525;7432.293932076444;7503.137139229058;7538.208488108889;7587.658555364911;7697.345725613385;7706.884396733942;5655.7172141393585;5663.85840353978;5712.143178523254;5740.68426236561;5768.798092066758;5974.551908606785;6241.843953901007;6345.333739957238;6348.206474190726;6366.808995730135;5962.731677074629;6125;6182.289036760651;6264.34224406449;6277.12120303167;5271.341082364705;5935.376785437639;5953.76184952597;6094.329623741296;6100.816975490742;6006.519478441802;6090;6102.9694851525455;6115.082737589397;6215.533834962305;5639.492445679744;5676.801311954062;5677.8864422710485;5687.971560142173;5692.48767610917;5759.596828221985;5833.4749872511675;5838.649681019152;5839.240898683314;5845.09401042839 22:26:11 INFO - 2015-11-25 22:26:11,640 DEBUG : BROWSER_OUTPUT: |4;prototype.html;298.2499014977332;301.4844615707141;309.7661265744362;310.1718411840386;311.2172885193738;5569.944300556993;5645.237892884465;5645.5483561314995;5782.10377391504;5794.362620111784;5586.608937374385;5651.2370829937945;5652.604317697763;5668.234788303578;5669.319681638209;4123.97938010311;4228.492580890297;4260.297050986584;4277.187334406468;4279.636230920375;4251.192273468031;4255.978720106411;4262.041040765834;4268.38108474271;4274.29474136767;4188.958110418903;4217.704760666755;4221.409002739619;4236.110416812473;4240.045989652334;4226.598473145046;4233.767142807144;4237.703360764748;4242.809073591665;4244.787760611988;3617.819109044537;3635.0185449928636;3647.252313275772;3647.288778688157;3666.5233519642543;5295.205719142121;5404.162354835007;5443.863903402446;5444.128939369722;5462.399136095027;4904.411470623512;4913.484084171147;4916;4925.950740492585;4926.778294976734;5931.6441013539325;5936.554758393095;5938.673372964486;5942.792002279943;5951.345352011275;3849.69202463805;3994.1612261425134;3998.5601583825755;4017.7388469749667;4024;6136.877262454771;6195.628262304276;6219.40915613016;6222.719977601018;6228.532860035471;4084.101497670508;4087.3868919662286;4095.8976025599004;4096.836126554964;4099.528554216304;4145.502539695256;4147.730397524151;4165.083681590046;4172.207280616673;4174.895627609273;4743.691660042086;4772.49888761675;4843.0313937211995;4846.61227101831;4847.757612119451;5842.883142337129;5880.970595147082;5883.558733095035;5884.558658100574;5905.557083218776;1469.977950330746;1481.6073740458787;1489.865912067919;1490.5230326295482;1490.9403623854923;992.0674565908023;992.2905122837207;1005.8642083318805;1010.2625083688948;1010.4644538394663;5120.487951204924;5125.2568377585785;5139.254808052811;5150.459201783834;5165.638405311667;6105.267367915879;6154.845803968575;6155.4767844732805;6157;6158.568900176944;5103.948960510422;5115.462876397924;5144.511271429208;5151.665141765849;5154.896902061938;3224.3228921926657;3261.2988207535495;3289.523019162208;3312.254742682877;3334.1497918030745;5760.0207964646115;5814.476697097281;5827.3298570664065;5841.474267315962;5849.736761845642;6382.20222472191;6385.2337719473035;6391.169148010729;6402.519811014193;6405.135306733625;5687.232223649837;5760.36635970043;5806.709664516758;5827.3007239131575;5842.386549412336;6192.225971753531;6193.628382296896;6195.96902015487;6197.535184861244;6202.224721909762;6026.548008899263;6040.305364883095;6048.5161187105805;6059.969700151471;6071.058985857199;5687.488126068673;5755.251817263729;5822.388649191774;5832.533397328289;5833.387494313036;4087.8569250076102;4127.215828992482;4135.813888375091;4136.482939632546;4146.212219678251;5927.051671732502;6066.787662431971;6165.660888651168;6168.599041062316;6172.290186628596;5817.592768506164;5933.110033495011;5933.436323549256;5953.672548009901;5968.746563221772;5930.080837470199;5931.08068249422;5944.970275148597;5945.732442040205;5975.193348898017;5658.462446067617;5773.711314434346;5813.94186058134;5828.970855145697;5831.8833623326445;5932.6737029462065;5962.16529685853;5962.37395073511;5968.970155149196;5970.31341395745;5781.508571771278;5817.156512305776;5827.125931110368;5828.067509198508;5849.093390524476 22:26:11 INFO - 2015-11-25 22:26:11,641 DEBUG : BROWSER_OUTPUT: |5;yui.html;632.9050642403641;655.9147310849589;674.2650510943071;730.466759265736;753.7851712262004;11246.943765281172;11514.654560363182;11523.13576481764;11536.365499897502;11552.942235288812;11746.119041071912;11750.529978800838;11811.350375729331;11828.822567661471;11842.230255033417;276.2568690223303;279.830702425033;735.0591243208702;745.3813334931993;752.2327226229243;751.6054071612392;758.0297219558973;758.3364556013488;762.3443838299058;766.3026645752367;796.5181065455403;803.3091541274499;803.9839203215932;804.4770898915693;805.5005896344275;795.6578671171394;799.2686691677137;799.9560024198666;800.5236884053978;801.2988634944395;594.3907494817803;595.9165716799652;596.1862058290445;596.4661627843057;597.7041364524545;11277.266977646426;11289;11319.717007074807;11398.658040258722;11469.082473402108;10497.265191436603;10773.892261077368;10857.294275872044;10909.399983000932;11006.174536909684;8752.256058235058;8951.283897288202;9009.369344145913;9154.588043538057;9243.722688319362;3178.904632861018;3195.1532843796413;3204.5513628092085;3216.308493673848;3236.1747754322496;42291.36562951558;42333.788331058146;42633.360499592534;42728.35907461391;42737;8878.600462979182;8894.73315800527;8912.242459390895;8939.642414303486;9019.413738107001;16406;16444.424445144363;16478.588035299214;16499.09254990987;16611.252493637574;6353.237611486558;6434;6495.188101487314;6542.3130571290285;6639.236487803964;3316.585426821647;3405.4210784166753;3439.6044454887506;3489.371913055674;3515.3672338978718;2633.4601406711963;2655.774259187952;2668.226214397803;2670.399160188942;2671.358873870296;455.19430607823966;463.76579827187055;467.03557154475897;472.7092837904664;479.5516192360154;528.822844347148;544.9564034877201;558.7625259264796;572.5105035194931;586.9941300587025;7622.5426474411715;7880.921190788019;7938.960305198437;8065.475744076616;8177.182281771775;455;461.766807762078;558.8239704493071;594.521410264741;601.5127746525328;3591;3670.632936706308;3698.20488594948;3776.8866933992026;3870.4968354113785;50730;50788;50974.235386469234;50992.49007509877;51229.231561526605;43560.82195890193;43665.34501982473;43937.560624393984;44319.335209971876;44372.55627443684;41353.586464134976;42506;42767.57232427698;43900;44316.55683443189;7831.2560306770765;7961.164077771982;8045.316148127475;8141.22658347456;8246.546439945621;32219.677803221668;32484.675153248165;32911.835440822644;33446.16384590405;33462;41258.38112428376;41492.79253603833;41558.376624351265;41720.58279417167;41993.37009944792;9085.54572271397;9212.723618291462;9511.143997040299;9920;9951.950240248752;10759.569617215224;10975.28660637056;11013.83479247828;11247;11397.658070257905;9642.084002019797;9863.210943124677;9905.851412228678;10136.391816491034;10573.52419141125;9830.627029727704;9911.553980071058;10019.799604008025;10028.64899728506;10421.739456513647;9294.628214871329;9345.672901448417;9712.902870971482;10552.314099583502;10703.785924281627;8566.48601083912;8598.78503037429;8857.247133993425;8877.778055548662;8961.596728147118;8579.35654825878;8788.2529984952;8809.11908809114;8922.509261990654;9086.136817002374 22:26:11 INFO - 2015-11-25 22:26:11,641 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:26:11 INFO - 2015-11-25 22:26:11,641 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,317 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: __startTimestamp1448519171633__endTimestamp 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4594.96 Median:4703.13 stddev:477.67 (10.2%) stddev-sans-first:454.55 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: Values: 2666.5 2668.3 2700.6 2713.3 2732.7 4481.5 4600.9 4654.1 4670.0 4756.5 4568.4 4592.7 4628.9 4639.8 4698.7 4079.5 4343.9 4346.4 4400.2 4411.2 4070.6 4328.4 4341.0 4373.6 4418.5 4185.7 4186.6 4198.0 4212.1 4299.7 4301.4 4302.5 4319.9 4328.8 4349.8 4288.6 4294.8 4301.3 4308.3 4355.8 4412.8 4415.6 4537.7 4551.2 4558.5 4942.6 5038.1 5046.1 5049.9 5092.6 4763.5 5042.7 5071.0 5071.4 5120.1 4548.8 4597.6 4607.7 4619.0 4647.8 5163.9 5173.3 5207.5 5209.0 5265.7 4677.7 4783.8 4976.6 4984.6 5037.1 4905.9 4960.4 4981.0 4989.7 5034.9 4918.4 5009.1 5011.4 5026.0 5039.1 4717.2 4828.4 4832.0 4951.5 5019.0 4185.4 4187.1 4192.9 4215.9 4230.4 3673.8 3676.0 3710.8 3714.1 3741.6 4080.0 4195.5 4197.1 4197.5 4368.2 4969.2 5007.6 5016.4 5021.3 5038.9 4348.7 4356.7 4359.1 4386.1 4386.8 4217.9 4306.5 4376.0 4426.5 4483.5 4724.5 4728.0 4731.1 4759.3 4780.8 4975.3 5005.2 5007.7 5007.9 5057.8 4565.9 4639.0 4698.4 4729.1 4753.6 4884.9 4911.9 4917.8 4930.5 4971.5 4990.4 4990.8 4997.5 5005.2 5066.4 4579.6 4687.4 4697.9 4751.0 4863.0 4815.1 4816.1 4829.1 4831.5 4879.8 4703.1 4742.6 4748.5 4753.2 4778.2 4609.1 4732.1 4788.2 4885.3 4919.2 4748.7 4811.0 4839.1 4840.2 4864.7 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44260.43 Median:3553.53 stddev:79313.52 (2232.0%) stddev-sans-first:79467.94 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: Values: 494.4 494.5 566.7 568.6 569.3 31538.2 31907.7 31953.0 32111.5 32128.2 40233.8 40812.4 40814.8 40842.4 40889.8 7904.2 8122.3 8173.8 8181.0 8188.5 7789.4 7898.4 7943.2 7957.6 7974.4 7993.5 8049.8 8113.8 8116.6 8136.0 7977.8 7987.9 8018.8 8036.4 8043.4 7900.5 8049.8 8051.5 8079.4 8088.6 37419.3 37791.8 38074.6 38086.0 38239.4 2651.8 2659.2 2793.9 3028.5 3076.8 28062.9 28272.2 28495.4 28579.7 28707.7 3384.4 3460.6 3505.2 3529.7 3577.4 327328.0 329966.0 331874.0 332091.0 332353.0 37627.4 37925.2 37944.4 54634.0 55613.4 36883.6 36889.4 36963.4 37134.6 37196.6 11256.9 11345.1 11365.4 11385.4 11419.1 9080.4 9171.4 9201.8 9230.6 9238.0 13320.4 13408.1 13409.5 13454.9 13465.3 4641.9 4663.1 4729.1 4790.6 4813.8 842.8 855.3 920.9 939.9 993.5 26299.6 26463.2 29435.7 29692.4 30619.4 883.9 894.7 957.0 970.7 1015.8 12828.0 12944.7 13019.3 13040.6 13044.4 316090.0 317762.0 320890.0 321098.0 321743.0 46809.0 47107.8 47117.8 47242.0 47414.0 1185.7 1186.5 1192.9 1198.3 1201.8 25397.6 25609.2 26009.7 26169.0 26259.0 38573.6 38906.6 39104.2 39254.8 39597.2 248002.0 248450.0 248675.0 249047.0 249584.0 29627.3 37801.4 38131.8 38222.4 38718.4 39478.6 39527.0 39718.6 40013.6 40308.8 33778.3 33966.8 34029.3 34098.7 34929.5 33768.5 33957.2 34091.5 34205.5 34237.3 33214.5 33788.0 33821.0 34041.0 34081.0 29553.9 30652.5 31124.0 31498.7 31622.7 21832.2 22007.1 22170.5 22185.9 22221.2 22:26:11 INFO - 2015-11-25 22:26:11,642 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,643 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25618.48 Median:249216.66 stddev:75229.07 (30.2%) stddev-sans-first:75416.15 22:26:11 INFO - 2015-11-25 22:26:11,644 DEBUG : BROWSER_OUTPUT: Values: 332.9 336.9 337.5 338.0 339.4 15185.8 15255.9 15961.2 16472.7 16794.2 9613.8 9825.5 12200.1 13881.5 13929.5 4683.7 4803.2 4805.7 4813.9 5099.6 5103.2 5126.0 5126.2 5162.1 5164.3 4940.7 5086.4 5097.5 5159.0 5173.5 4864.4 5075.3 5109.5 5116.6 5147.6 4836.9 4844.1 4846.6 4846.9 4850.9 11539.0 19125.5 19147.6 19402.0 19667.2 1792.2 1799.6 1839.4 1847.5 1890.4 9038.6 9053.5 9169.1 9330.6 10587.8 1578.8 1649.4 1728.4 1767.2 1777.0 54023.5 56148.7 57282.7 57530.1 57734.4 9573.0 9754.5 9855.4 9900.9 9955.7 12399.6 12468.7 12549.4 12549.8 12575.8 6538.1 6778.0 6938.5 6984.2 7020.1 6729.3 6738.2 6742.9 6801.5 6803.3 4182.7 4244.3 4255.4 4258.1 4259.0 1515.4 1756.9 1776.5 1783.4 1815.3 730.3 765.4 824.0 898.2 968.0 15361.5 15447.2 15451.7 16044.9 16060.0 761.6 822.4 830.8 840.8 913.5 8159.0 8240.4 8442.2 8627.2 9242.1 452533.0 459426.0 460020.0 460246.6 468137.0 70128.0 70603.3 71968.0 72784.3 72962.0 1024.0 1028.9 1037.9 1038.4 1039.3 14211.8 14291.1 14322.7 14380.6 14430.6 32548.3 32820.3 32854.5 34047.5 34107.8 44339.6 45900.3 46162.3 46493.3 47272.0 8884.0 9107.9 9280.9 9294.4 9299.8 15990.4 16066.0 16117.5 16227.0 16372.8 12684.6 13127.5 13366.4 13442.0 13715.9 13150.9 13415.9 13821.5 14133.1 14209.4 12791.0 12933.8 12952.0 13003.1 13161.7 8723.3 9009.2 9053.9 9092.4 9229.3 12737.7 13140.6 13215.2 13340.7 14001.6 22:26:11 INFO - 2015-11-25 22:26:11,644 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,644 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4752.20 Median:5990.54 stddev:2480.24 (41.4%) stddev-sans-first:2474.00 22:26:11 INFO - 2015-11-25 22:26:11,645 DEBUG : BROWSER_OUTPUT: Values: 1347.7 1352.4 1397.1 1565.8 1633.6 6709.4 7049.7 7070.3 7097.4 7162.2 6985.4 6997.3 7043.1 7048.0 7061.9 2040.8 2066.2 2068.3 2082.3 2085.9 2069.7 2075.5 2094.3 2114.4 2115.3 2024.0 2069.4 2069.9 2081.5 2089.5 2026.1 2045.4 2048.8 2049.8 2050.9 2064.4 2100.3 2103.8 2106.3 2113.0 6822.2 6889.3 6931.5 6937.6 6964.8 3937.9 3982.9 3995.5 4000.5 4004.7 2730.9 2736.7 2805.5 2823.8 2828.8 836.2 837.7 840.3 846.2 877.3 9195.0 9206.7 9234.3 9259.0 9266.2 3614.7 3667.5 3700.6 3775.3 3778.5 7515.5 7584.3 7586.2 7596.6 7623.7 3960.6 3969.9 3974.1 3975.0 3976.8 3573.4 3614.8 3615.8 3631.3 3637.2 2979.9 3017.3 3047.7 3049.6 3075.8 922.9 926.6 931.1 931.5 934.6 664.5 665.4 669.1 669.5 751.9 6132.7 6482.2 6484.3 6501.6 6514.7 853.0 867.4 867.7 924.2 1003.3 5049.7 5075.0 5111.5 5121.3 5137.3 8249.4 8348.1 8491.0 8556.7 8614.4 8402.3 8416.9 8458.9 8460.3 8491.7 6091.7 6170.9 6238.2 6252.9 6289.0 5810.6 5854.6 5866.6 5882.2 5890.4 7164.7 7257.0 7353.9 7408.3 7432.3 7503.1 7538.2 7587.7 7697.3 7706.9 5655.7 5663.9 5712.1 5740.7 5768.8 5974.6 6241.8 6345.3 6348.2 6366.8 5962.7 6125.0 6182.3 6264.3 6277.1 5271.3 5935.4 5953.8 6094.3 6100.8 6006.5 6090.0 6103.0 6115.1 6215.5 5639.5 5676.8 5677.9 5688.0 5692.5 5759.6 5833.5 5838.6 5839.2 5845.1 22:26:11 INFO - 2015-11-25 22:26:11,645 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,646 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4875.00 Median:5645.39 stddev:1470.28 (26.0%) stddev-sans-first:1433.71 22:26:11 INFO - 2015-11-25 22:26:11,647 DEBUG : BROWSER_OUTPUT: Values: 298.2 301.5 309.8 310.2 311.2 5569.9 5645.2 5645.5 5782.1 5794.4 5586.6 5651.2 5652.6 5668.2 5669.3 4124.0 4228.5 4260.3 4277.2 4279.6 4251.2 4256.0 4262.0 4268.4 4274.3 4189.0 4217.7 4221.4 4236.1 4240.0 4226.6 4233.8 4237.7 4242.8 4244.8 3617.8 3635.0 3647.3 3647.3 3666.5 5295.2 5404.2 5443.9 5444.1 5462.4 4904.4 4913.5 4916.0 4926.0 4926.8 5931.6 5936.6 5938.7 5942.8 5951.3 3849.7 3994.2 3998.6 4017.7 4024.0 6136.9 6195.6 6219.4 6222.7 6228.5 4084.1 4087.4 4095.9 4096.8 4099.5 4145.5 4147.7 4165.1 4172.2 4174.9 4743.7 4772.5 4843.0 4846.6 4847.8 5842.9 5881.0 5883.6 5884.6 5905.6 1470.0 1481.6 1489.9 1490.5 1490.9 992.1 992.3 1005.9 1010.3 1010.5 5120.5 5125.3 5139.3 5150.5 5165.6 6105.3 6154.8 6155.5 6157.0 6158.6 5103.9 5115.5 5144.5 5151.7 5154.9 3224.3 3261.3 3289.5 3312.3 3334.1 5760.0 5814.5 5827.3 5841.5 5849.7 6382.2 6385.2 6391.2 6402.5 6405.1 5687.2 5760.4 5806.7 5827.3 5842.4 6192.2 6193.6 6196.0 6197.5 6202.2 6026.5 6040.3 6048.5 6060.0 6071.1 5687.5 5755.3 5822.4 5832.5 5833.4 4087.9 4127.2 4135.8 4136.5 4146.2 5927.1 6066.8 6165.7 6168.6 6172.3 5817.6 5933.1 5933.4 5953.7 5968.7 5930.1 5931.1 5945.0 5945.7 5975.2 5658.5 5773.7 5813.9 5829.0 5831.9 5932.7 5962.2 5962.4 5969.0 5970.3 5781.5 5817.2 5827.1 5828.1 5849.1 22:26:11 INFO - 2015-11-25 22:26:11,647 DEBUG : BROWSER_OUTPUT: 22:26:11 INFO - 2015-11-25 22:26:11,647 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12341.11 Median:25604.78 stddev:14331.44 (56.0%) stddev-sans-first:14344.67 22:26:11 INFO - 2015-11-25 22:26:11,648 DEBUG : BROWSER_OUTPUT: Values: 632.9 655.9 674.3 730.5 753.8 11246.9 11514.7 11523.1 11536.4 11552.9 11746.1 11750.5 11811.4 11828.8 11842.2 276.3 279.8 735.1 745.4 752.2 751.6 758.0 758.3 762.3 766.3 796.5 803.3 804.0 804.5 805.5 795.7 799.3 800.0 800.5 801.3 594.4 595.9 596.2 596.5 597.7 11277.3 11289.0 11319.7 11398.7 11469.1 10497.3 10773.9 10857.3 10909.4 11006.2 8752.3 8951.3 9009.4 9154.6 9243.7 3178.9 3195.2 3204.6 3216.3 3236.2 42291.4 42333.8 42633.4 42728.4 42737.0 8878.6 8894.7 8912.2 8939.6 9019.4 16406.0 16444.4 16478.6 16499.1 16611.3 6353.2 6434.0 6495.2 6542.3 6639.2 3316.6 3405.4 3439.6 3489.4 3515.4 2633.5 2655.8 2668.2 2670.4 2671.4 455.2 463.8 467.0 472.7 479.6 528.8 545.0 558.8 572.5 587.0 7622.5 7880.9 7939.0 8065.5 8177.2 455.0 461.8 558.8 594.5 601.5 3591.0 3670.6 3698.2 3776.9 3870.5 50730.0 50788.0 50974.2 50992.5 51229.2 43560.8 43665.3 43937.6 44319.3 44372.6 41353.6 42506.0 42767.6 43900.0 44316.6 7831.3 7961.2 8045.3 8141.2 8246.5 32219.7 32484.7 32911.8 33446.2 33462.0 41258.4 41492.8 41558.4 41720.6 41993.4 9085.5 9212.7 9511.1 9920.0 9952.0 10759.6 10975.3 11013.8 11247.0 11397.7 9642.1 9863.2 9905.9 10136.4 10573.5 9830.6 9911.6 10019.8 10028.6 10421.7 9294.6 9345.7 9712.9 10552.3 10703.8 8566.5 8598.8 8857.2 8877.8 8961.6 8579.4 8788.3 8809.1 8922.5 9086.1 22:26:11 INFO - 2015-11-25 22:26:11,649 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:26:11 INFO - 2015-11-25 22:26:11,649 DEBUG : BROWSER_OUTPUT: 22:26:12 INFO - 2015-11-25 22:26:12,441 INFO : Browser exited with error code: 0 22:26:12 INFO - 2015-11-25 22:26:12,459 INFO : Completed test dromaeo_css (00:18:33) 22:26:12 INFO - 2015-11-25 22:26:12,459 INFO : Starting test kraken 22:26:12 INFO - 2015-11-25 22:26:12,459 DEBUG : operating with platform_type : linux_ 22:26:12 INFO - 2015-11-25 22:26:12,459 INFO : Initialising browser for kraken test... 22:26:12 INFO - 2015-11-25 22:26:12,465 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFB8dq9/profile http://localhost:49931/getInfo.html 22:26:16 INFO - 2015-11-25 22:26:16,943 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:26:16 INFO - 2015-11-25 22:26:16,943 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:26:16 INFO - 2015-11-25 22:26:16,943 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:26:16 INFO - 2015-11-25 22:26:16,943 DEBUG : BROWSER_OUTPUT: __metrics 22:26:17 INFO - 2015-11-25 22:26:17,980 INFO : Browser initialized. 22:26:17 INFO - 2015-11-25 22:26:17,981 INFO : Running cycle 1/1 for kraken test... 22:26:17 INFO - 2015-11-25 22:26:17,981 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpFB8dq9/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:26:29 INFO - 2015-11-25 22:26:29,972 DEBUG : BROWSER_OUTPUT: RSS: Main: 140550144 22:26:29 INFO - 2015-11-25 22:26:29,973 DEBUG : BROWSER_OUTPUT: 22:26:32 INFO - 2015-11-25 22:26:32,555 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49931/tests/kraken/driver.html?testName=audio-beat-detection) 22:26:33 INFO - 2015-11-25 22:26:33,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 140443648 22:26:33 INFO - 2015-11-25 22:26:33,177 DEBUG : BROWSER_OUTPUT: 22:26:35 INFO - 2015-11-25 22:26:35,939 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49931/tests/kraken/driver.html?testName=audio-dft) 22:26:36 INFO - 2015-11-25 22:26:36,541 DEBUG : BROWSER_OUTPUT: RSS: Main: 140820480 22:26:36 INFO - 2015-11-25 22:26:36,541 DEBUG : BROWSER_OUTPUT: 22:26:39 INFO - 2015-11-25 22:26:39,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49931/tests/kraken/driver.html?testName=audio-fft) 22:26:40 INFO - 2015-11-25 22:26:40,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 135667712 22:26:40 INFO - 2015-11-25 22:26:40,026 DEBUG : BROWSER_OUTPUT: 22:26:42 INFO - 2015-11-25 22:26:42,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49931/tests/kraken/driver.html?testName=audio-oscillator) 22:26:42 INFO - 2015-11-25 22:26:42,731 DEBUG : BROWSER_OUTPUT: RSS: Main: 136564736 22:26:42 INFO - 2015-11-25 22:26:42,731 DEBUG : BROWSER_OUTPUT: 22:26:45 INFO - 2015-11-25 22:26:45,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49931/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:26:45 INFO - 2015-11-25 22:26:45,586 DEBUG : BROWSER_OUTPUT: RSS: Main: 137932800 22:26:45 INFO - 2015-11-25 22:26:45,586 DEBUG : BROWSER_OUTPUT: 22:26:48 INFO - 2015-11-25 22:26:48,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49931/tests/kraken/driver.html?testName=imaging-darkroom) 22:26:49 INFO - 2015-11-25 22:26:49,230 DEBUG : BROWSER_OUTPUT: RSS: Main: 138346496 22:26:49 INFO - 2015-11-25 22:26:49,230 DEBUG : BROWSER_OUTPUT: 22:26:52 INFO - 2015-11-25 22:26:52,751 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49931/tests/kraken/driver.html?testName=imaging-desaturate) 22:26:53 INFO - 2015-11-25 22:26:53,344 DEBUG : BROWSER_OUTPUT: RSS: Main: 135884800 22:26:53 INFO - 2015-11-25 22:26:53,344 DEBUG : BROWSER_OUTPUT: 22:26:56 INFO - 2015-11-25 22:26:56,276 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49931/tests/kraken/driver.html?testName=json-parse-financial) 22:26:56 INFO - 2015-11-25 22:26:56,865 DEBUG : BROWSER_OUTPUT: RSS: Main: 136609792 22:26:56 INFO - 2015-11-25 22:26:56,865 DEBUG : BROWSER_OUTPUT: 22:26:58 INFO - 2015-11-25 22:26:58,654 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49931/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:26:59 INFO - 2015-11-25 22:26:59,235 DEBUG : BROWSER_OUTPUT: RSS: Main: 137646080 22:26:59 INFO - 2015-11-25 22:26:59,236 DEBUG : BROWSER_OUTPUT: 22:27:01 INFO - 2015-11-25 22:27:01,151 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:27:01 INFO - 2015-11-25 22:27:01,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 138682368 22:27:01 INFO - 2015-11-25 22:27:01,760 DEBUG : BROWSER_OUTPUT: 22:27:03 INFO - 2015-11-25 22:27:03,892 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:27:04 INFO - 2015-11-25 22:27:04,485 DEBUG : BROWSER_OUTPUT: RSS: Main: 138432512 22:27:04 INFO - 2015-11-25 22:27:04,485 DEBUG : BROWSER_OUTPUT: 22:27:07 INFO - 2015-11-25 22:27:07,086 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:27:07 INFO - 2015-11-25 22:27:07,681 DEBUG : BROWSER_OUTPUT: RSS: Main: 138825728 22:27:07 INFO - 2015-11-25 22:27:07,681 DEBUG : BROWSER_OUTPUT: 22:27:10 INFO - 2015-11-25 22:27:10,316 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:27:10 INFO - 2015-11-25 22:27:10,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 137732096 22:27:10 INFO - 2015-11-25 22:27:10,904 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,673 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49931/tests/kraken/driver.html?testName=ai-astar) 22:27:12 INFO - 2015-11-25 22:27:12,924 DEBUG : BROWSER_OUTPUT: RSS: Main: 137883648 22:27:12 INFO - 2015-11-25 22:27:12,924 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,926 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:12 INFO - 2015-11-25 22:27:12,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:12 INFO - 2015-11-25 22:27:12,926 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:12 INFO - 2015-11-25 22:27:12,927 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:12 INFO - 2015-11-25 22:27:12,928 DEBUG : BROWSER_OUTPUT: |0;ai-astar;113;108;116;113;114;125;113;113;115;114 22:27:12 INFO - 2015-11-25 22:27:12,928 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;160;131;159;162;135;169;154;131;169;142 22:27:12 INFO - 2015-11-25 22:27:12,928 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;163;162;162;164;167;161;166;164 22:27:12 INFO - 2015-11-25 22:27:12,928 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;76;75;74;75;72;135;73;72;76 22:27:12 INFO - 2015-11-25 22:27:12,929 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;96;95;133;94;95;95;133;94;96;130 22:27:12 INFO - 2015-11-25 22:27:12,929 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;111;111;110;110;110;110;111 22:27:12 INFO - 2015-11-25 22:27:12,929 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;148;148;149;148;147;149;147;149 22:27:12 INFO - 2015-11-25 22:27:12,929 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;97;97;96;96;96;97;96;97 22:27:12 INFO - 2015-11-25 22:27:12,930 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;74;74;77;78;75;73;74;74;74;72 22:27:12 INFO - 2015-11-25 22:27:12,930 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;71;69;69;70;69;69;69;71;68 22:27:12 INFO - 2015-11-25 22:27:12,930 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;84;83;85;83;83;84;84;85;84 22:27:12 INFO - 2015-11-25 22:27:12,930 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;119;130;121;126;128;132;123;126;126;134 22:27:12 INFO - 2015-11-25 22:27:12,930 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;139;148;146;150;152;154;148;150;146;147 22:27:12 INFO - 2015-11-25 22:27:12,931 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;70;70;71;72;72;71;68;71;72;70 22:27:12 INFO - 2015-11-25 22:27:12,931 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:12 INFO - 2015-11-25 22:27:12,931 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:27:12 INFO - 2015-11-25 22:27:12,931 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,767 22:27:12 INFO - 2015-11-25 22:27:12,931 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:27:12 INFO - 2015-11-25 22:27:12,932 DEBUG : BROWSER_OUTPUT: __startTimestamp1448519232925__endTimestamp 22:27:12 INFO - 2015-11-25 22:27:12,932 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,935 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:12 INFO - 2015-11-25 22:27:12,935 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:114.40 Median:114.00 stddev:4.27 (3.7%) stddev-sans-first:4.50 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: Values: 113.0 108.0 116.0 113.0 114.0 125.0 113.0 113.0 115.0 114.0 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:151.20 Median:159.50 stddev:15.13 (9.5%) stddev-sans-first:15.71 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: Values: 160.0 131.0 159.0 162.0 135.0 169.0 154.0 131.0 169.0 142.0 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:163.50 Median:164.00 stddev:1.90 (1.2%) stddev-sans-first:2.01 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 163.0 162.0 162.0 164.0 167.0 161.0 166.0 164.0 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,936 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.10 Median:74.50 stddev:19.35 (26.0%) stddev-sans-first:20.35 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 75.0 74.0 75.0 72.0 135.0 73.0 72.0 76.0 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.10 Median:95.00 stddev:17.90 (18.8%) stddev-sans-first:18.61 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 133.0 94.0 95.0 95.0 133.0 94.0 96.0 130.0 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:110.30 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.50 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 111.0 111.0 110.0 110.0 110.0 110.0 111.0 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:148.00 Median:148.00 stddev:0.82 (0.6%) stddev-sans-first:0.78 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 148.0 148.0 149.0 148.0 147.0 149.0 147.0 149.0 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:96.30 Median:96.50 stddev:0.67 (0.7%) stddev-sans-first:0.53 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 97.0 97.0 96.0 96.0 96.0 97.0 96.0 97.0 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,937 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.50 Median:74.00 stddev:1.78 (2.4%) stddev-sans-first:1.88 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: Values: 74.0 74.0 77.0 78.0 75.0 73.0 74.0 74.0 74.0 72.0 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.40 Median:69.00 stddev:0.97 (1.4%) stddev-sans-first:1.01 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 69.0 69.0 70.0 69.0 69.0 69.0 71.0 68.0 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:0.79 (0.9%) stddev-sans-first:0.78 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: Values: 83.0 84.0 83.0 85.0 83.0 83.0 84.0 84.0 85.0 84.0 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.50 Median:127.00 stddev:4.72 (3.7%) stddev-sans-first:4.15 22:27:12 INFO - 2015-11-25 22:27:12,938 DEBUG : BROWSER_OUTPUT: Values: 119.0 130.0 121.0 126.0 128.0 132.0 123.0 126.0 126.0 134.0 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:149.00 stddev:4.08 (2.7%) stddev-sans-first:2.74 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: Values: 139.0 148.0 146.0 150.0 152.0 154.0 148.0 150.0 146.0 147.0 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.70 Median:71.00 stddev:1.25 (1.8%) stddev-sans-first:1.30 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 72.0 72.0 71.0 68.0 71.0 72.0 70.0 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:12 INFO - 2015-11-25 22:27:12,939 DEBUG : BROWSER_OUTPUT: 22:27:13 INFO - 2015-11-25 22:27:13,833 INFO : Browser exited with error code: 0 22:27:13 INFO - 2015-11-25 22:27:13,886 INFO : Completed test kraken (00:01:01) 22:27:13 INFO - 2015-11-25 22:27:13,886 INFO : Starting test v8_7 22:27:13 INFO - 2015-11-25 22:27:13,886 DEBUG : operating with platform_type : linux_ 22:27:13 INFO - 2015-11-25 22:27:13,886 INFO : Initialising browser for v8_7 test... 22:27:13 INFO - 2015-11-25 22:27:13,892 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4qdCG8/profile http://localhost:49931/getInfo.html 22:27:18 INFO - 2015-11-25 22:27:18,338 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:27:18 INFO - 2015-11-25 22:27:18,338 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:27:18 INFO - 2015-11-25 22:27:18,338 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:27:18 INFO - 2015-11-25 22:27:18,338 DEBUG : BROWSER_OUTPUT: __metrics 22:27:19 INFO - 2015-11-25 22:27:19,388 INFO : Browser initialized. 22:27:19 INFO - 2015-11-25 22:27:19,389 INFO : Running cycle 1/1 for v8_7 test... 22:27:19 INFO - 2015-11-25 22:27:19,389 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp4qdCG8/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:27:31 INFO - 2015-11-25 22:27:31,295 DEBUG : BROWSER_OUTPUT: RSS: Main: 138465280 22:27:31 INFO - 2015-11-25 22:27:31,295 DEBUG : BROWSER_OUTPUT: 22:27:52 INFO - 2015-11-25 22:27:52,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49931/tests/v8_7/run.html (next: http://localhost:49931/tests/v8_7/run.html) 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: RSS: Main: 137306112 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:27:53 INFO - 2015-11-25 22:27:53,037 DEBUG : BROWSER_OUTPUT: |0;Richards;173.79214459506431 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;184.1620626151013 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.4694783573807 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5229.166666666667 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1072.8831725616292 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |5;Earley;706.2146892655368 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |6;Boyer;12562.5 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |7;RegExp;26153.846153846152 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |8;Splay;610.8735491753207 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: __startTimestamp1448519273031__endTimestamp 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:27:53 INFO - 2015-11-25 22:27:53,038 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:173.79 Median:173.79 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: Values: 173.8 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:184.16 Median:184.16 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: Values: 184.2 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.47 Median:277.47 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: Values: 277.5 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5229.17 Median:5229.17 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: Values: 5229.2 22:27:53 INFO - 2015-11-25 22:27:53,039 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1072.88 Median:1072.88 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: Values: 1072.9 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:706.21 Median:706.21 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: Values: 706.2 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12562.50 Median:12562.50 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: Values: 12562.5 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26153.85 Median:26153.85 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: Values: 26153.8 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:610.87 Median:610.87 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: Values: 610.9 22:27:53 INFO - 2015-11-25 22:27:53,040 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,041 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 22:27:53 INFO - 2015-11-25 22:27:53,041 DEBUG : BROWSER_OUTPUT: Values: 4840.6 22:27:53 INFO - 2015-11-25 22:27:53,041 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:27:53 INFO - 2015-11-25 22:27:53,041 DEBUG : BROWSER_OUTPUT: 22:27:53 INFO - 2015-11-25 22:27:53,920 INFO : Browser exited with error code: 0 22:27:53 INFO - 2015-11-25 22:27:53,937 INFO : Completed test v8_7 (00:00:40) 22:27:54 INFO - 2015-11-25 22:27:54,034 INFO : Completed test suite (00:20:15) 22:27:54 INFO - 2015-11-25 22:27:54,034 DEBUG : Working with test: dromaeo_css 22:27:54 INFO - 2015-11-25 22:27:54,034 DEBUG : Generating results file: dromaeo_css 22:27:54 INFO - 2015-11-25 22:27:54,035 DEBUG : Working with test: kraken 22:27:54 INFO - 2015-11-25 22:27:54,036 DEBUG : Generating results file: kraken 22:27:54 INFO - 2015-11-25 22:27:54,036 INFO : javascript benchmark 22:27:54 INFO - 2015-11-25 22:27:54,036 DEBUG : Working with test: v8_7 22:27:54 INFO - 2015-11-25 22:27:54,036 DEBUG : Generating results file: v8_7 22:27:54 INFO - 2015-11-25 22:27:54,037 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:54 INFO - 2015-11-25 22:27:54,082 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,132,43]] 22:27:54 INFO - 2015-11-25 22:27:54,082 DEBUG : process_Request line: dromaeo_css 6221.68 graph.html#tests=[[72,132,43]] 22:27:54 INFO - 2015-11-25 22:27:54,082 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:54 INFO - 2015-11-25 22:27:54,107 DEBUG : process_Request line: kraken 1542.80 graph.html#tests=[[232,132,43]] 22:27:54 INFO - 2015-11-25 22:27:54,107 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:27:54 INFO - 2015-11-25 22:27:54,137 DEBUG : process_Request line: v8_7 21190.55 graph.html#tests=[[230,132,43]] 22:27:54 INFO - 2015-11-25 22:27:54,138 INFO : javascript benchmark 22:27:54 INFO - 2015-11-25 22:27:54,141 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2666.5466870631994, 2668.2795645175793, 2700.594910763385, 2713.3216695826045, 2732.685741139769, 4481.529439408864, 4600.884977875555, 4654.0924519718665, 4669.976650116753, 4756.476787553366, 4568.360429539867, 4592.701474404162, 4628.90742185157, 4639.7912093955765, 4698.718076915387, 4079.530853951789, 4343.93484097738, 4346.4349634547625, 4400.163968845925, 4411.228035093862, 4070.5522392536795, 4328.437303150586, 4341.02326976431, 4373.606375426211, 4418.513963464016, 4185.66514678828, 4186.6022727840655, 4197.999999999969, 4212.115455754265, 4299.742015479082, 4301.376300436419, 4302.5052119006405, 4319.913601727979, 4328.826846926151, 4349.7825108744755, 4288.635465985395, 4294.849680261176, 4301.268784306675, 4308.310670292738, 4355.84754533593, 4412.823487060514, 4415.602595766364, 4537.682362234645, 4551.226291530448, 4558.49856515783, 4942.604591632661, 5038.067957427887, 5046.09170349337, 5049.899002019975, 5092.643514953955, 4763.499832517605, 5042.672226305279, 5070.974645126787, 5071.416787069497, 5120.1039818031695, 4548.795304211285, 4597.632189424871, 4607.7004994675235, 4619.030003699261, 4647.790849411717, 5163.870903227449, 5173.301604283449, 5207.505286997729, 5209.036328279205, 5265.710385928811, 4677.672562920563, 4783.832565860248, 4976.552110310089, 4984.6261530384645, 5037.093323201859, 4905.901881962341, 4960.379952505937, 4980.950190498121, 4989.700617962933, 5034.899302014012, 4918.385201849769, 5009.073321435546, 5011.448740638527, 5026.019926114445, 5039.118154323052, 4717.174494463524, 4828.444728856156, 4832.0, 4951.529604687549, 5018.974905125451, 4185.3931179979345, 4187.078842654611, 4192.853250136231, 4215.852445164466, 4230.407742915994, 3673.7979411132646, 3675.963240367562, 3710.8330125144435, 3714.1271801126713, 3741.607131251234, 4080.0411903202726, 4195.454590903163, 4197.118605092965, 4197.454330936958, 4368.213721530155, 4969.18008528596, 5007.574356179693, 5016.423111342242, 5021.271915572222, 5038.874028149326, 4348.652107831366, 4356.738595684269, 4359.149965756647, 4386.1008493258805, 4386.758728269912, 4217.91564168721, 4306.461692288464, 4376.0, 4426.490953540384, 4483.529229430863, 4724.480307166277, 4727.976360118246, 4731.077439899186, 4759.262314341283, 4780.808767649255, 4975.253711943237, 5005.249212618136, 5007.7245751484015, 5007.874803129951, 5057.848264552069, 4565.863024109282, 4639.048994955959, 4698.412698412699, 4729.148753224453, 4753.643476739189, 4884.90230195387, 4911.852644420673, 4917.827876024322, 4930.457649658463, 4971.477994810638, 4990.3762029746285, 4990.775415106256, 4997.525235102659, 5005.199168133081, 5066.392032956069, 4579.564941330568, 4687.36720542736, 4697.906041879211, 4750.952490475051, 4862.978774457403, 4815.109204797123, 4816.133096042746, 4829.058333624909, 4831.492693267156, 4879.829205977774, 4703.129920964632, 4742.596879265163, 4748.4776674566465, 4753.239481682914, 4778.187708089564, 4609.101225261042, 4732.077244937204, 4788.209945359116, 4885.267209918541, 4919.1883339248625, 4748.691335063209, 4811.0, 4839.128956787812, 4840.1529732296, 4864.708117512961], "unit": "ms", "name": "dojo.html", "value": 4565.916122083275}, {"lowerIsBetter": false, "replicates": [494.4091810286709, 494.49561447323754, 566.7251383079206, 568.573569822633, 569.2798609758656, 31538.211544711365, 31907.68092319079, 31953.0, 32111.51832722511, 32128.196795080075, 40233.798831005806, 40812.38781418281, 40814.79592602033, 40842.38736418956, 40889.795551022275, 7904.249096335839, 8122.309603683664, 8173.836523269531, 8180.9590952045455, 8188.467749596287, 7789.3768498519985, 7898.368130549542, 7943.24539168778, 7957.602119894011, 7974.401919856005, 7993.520388776663, 8049.839003219932, 8113.823495593165, 8116.553589552572, 8135.959320203391, 7977.760667179994, 7987.880181797278, 8018.799530011738, 8036.397270204758, 8043.436959412844, 7900.486468379537, 8049.758507244792, 8051.476654017529, 8079.394045446556, 8088.636011379502, 37419.25161496782, 37791.811040944616, 38074.61925380738, 38086.0, 38239.4264086039, 2651.814372993891, 2659.228823641142, 2793.8742756576003, 3028.5457181422744, 3076.769242306836, 28062.859685701646, 28272.15183544497, 28495.430091398262, 28579.714202857915, 28707.71292287092, 3384.4077286474767, 3460.5501284832812, 3505.2288496530723, 3529.6999755020597, 3577.3560759063357, 327328.0, 329966.0, 331874.0, 332091.0, 332353.0, 37627.43558846619, 37925.24149516994, 37944.43083353752, 54634.0, 55613.443865560825, 36883.63116368856, 36889.44665830015, 36963.4455483168, 37134.628653713655, 37196.628033719855, 11256.943715281535, 11345.09239260857, 11365.431728413547, 11385.430728463543, 11419.086473082134, 9080.40977336471, 9171.403858749294, 9201.815963680689, 9230.58462369195, 9238.0, 13320.400581973834, 13408.128471649312, 13409.530666426823, 13454.93272533631, 13465.259410732504, 4641.86074417768, 4663.114008338405, 4729.101470720552, 4790.640701947298, 4813.831515896927, 842.8440738463404, 855.2644725536034, 920.8848893888264, 939.9248060155171, 993.4684943555163, 26299.605505917425, 26463.206103816916, 29435.705642943296, 29692.406151877272, 30619.38761224763, 883.902770695223, 894.7136916186757, 957.008975058258, 970.6651205334149, 1015.7968406318765, 12828.03789715775, 12944.741105177844, 13019.283939383426, 13040.608781736562, 13044.413001414769, 316090.0, 317762.0, 320890.0, 321098.0, 321743.0, 46809.0, 47107.764461177474, 47117.76441117841, 47242.0, 47414.0, 1185.6739396665814, 1186.5135294529202, 1192.9455433261587, 1198.3349241171234, 1201.8077107662557, 25397.61903571411, 25609.23172304834, 26009.73990260149, 26169.0, 26259.0, 38573.614263857, 38906.6109338903, 39104.2179156421, 39254.80372598233, 39597.2080558393, 248002.0, 248450.0, 248675.0, 249047.0, 249584.0, 29627.259318517208, 37801.432978504796, 38131.80934095312, 38222.42666360062, 38718.41922371223, 39478.60521394864, 39527.0, 39718.60281397265, 40013.59986400215, 40308.798456007535, 33778.32443351168, 33966.83016584901, 34029.31941361209, 34098.659013409546, 34929.47605785864, 33768.49347259744, 33957.151071222426, 34091.488627671104, 34205.48691769576, 34237.315253695284, 33214.501782473766, 33788.0, 33821.0, 34041.0, 34081.0, 29553.85223073957, 30652.540211896394, 31124.0, 31498.68501315049, 31622.683773161974, 21832.23587174441, 22007.11971521121, 22170.452727563512, 22185.889070554545, 22221.22225722092], "unit": "ms", "name": "ext.html", "value": 16372.255411478476}, {"lowerIsBetter": false, "replicates": [332.9151066478049, 336.9022983334833, 337.5308321433208, 337.9577552805901, 339.42806371264413, 15185.848141518582, 15255.923720381397, 15961.201939902987, 16472.670546589063, 16794.24425900836, 9613.759656008604, 9825.508724563779, 12200.145989780718, 13881.514147004857, 13929.512467063654, 4683.718976861391, 4803.183458811993, 4805.687630304019, 4813.90372192556, 5099.617528685363, 5103.23451482277, 5125.974370128144, 5126.154184559543, 5162.1224391853475, 5164.277001219813, 4940.678855874375, 5086.389633244016, 5097.464766199551, 5158.9742051289695, 5173.456787037363, 4864.391951006124, 5075.289459475676, 5109.463506331819, 5116.565091967169, 5147.562457191143, 4836.879078023042, 4844.103840789465, 4846.563809257149, 4846.927296090562, 4850.927236091461, 11539.0, 19125.521861953424, 19147.61704765897, 19402.0, 19667.213311467523, 1792.1845560270046, 1799.5770993816443, 1839.383806424836, 1847.5288801355703, 1890.395073576456, 9038.593263303168, 9053.547322633907, 9169.128932751379, 9330.580123894373, 10587.84118238227, 1578.7552929295978, 1649.4144578674639, 1728.3605066125615, 1767.1517671517743, 1776.9733453998201, 54023.45976540224, 56148.71925640386, 57282.713586431804, 57530.1370479439, 57734.42265577374, 9573.0, 9754.488054351586, 9855.408675479493, 9900.900990990142, 9955.651552195783, 12399.566015189424, 12468.688282793002, 12549.372531373394, 12549.811752823714, 12575.811362829565, 6538.084668146464, 6778.0, 6938.514303998772, 6984.2317345092, 7020.087388639444, 6729.327067293231, 6738.19141702989, 6742.8651426972165, 6801.4898882584, 6803.251642319341, 4182.749035057906, 4244.2996905510245, 4255.404243405926, 4258.1057977824385, 4258.957410425918, 1515.3635473101324, 1756.8682348823888, 1776.538100093985, 1783.4293026231742, 1815.2738904438065, 730.3135053050116, 765.4068097224696, 823.9546824924566, 898.1826537850525, 967.9854802177973, 15361.539153825403, 15447.227638618024, 15451.690966180613, 16044.919775401047, 16060.0, 761.5582961882095, 822.4448497264323, 830.8462934357163, 840.815020695446, 913.5340976102236, 8158.959205203936, 8240.423170378015, 8442.155784421631, 8627.22354988054, 9242.12199841014, 452533.0, 459426.0, 460020.0, 460246.5778079922, 468137.0, 70128.0, 70603.2939670607, 71968.0, 72784.27215727881, 72962.0, 1023.9846402303972, 1028.9125424339015, 1037.911777498921, 1038.4496217004998, 1039.2569312941284, 14211.786823197866, 14291.142531448146, 14322.713545729235, 14380.640483987983, 14430.567082987527, 32548.349033018734, 32820.343593128484, 32854.507182391804, 34047.48928766021, 34107.82946085254, 44339.55660443483, 45900.31149532693, 46162.307565387215, 46493.302600460345, 47272.0, 8884.0, 9107.863382049407, 9280.907190928005, 9294.395864268801, 9299.76750581241, 15990.360385584447, 16066.0, 16117.516474505315, 16227.0, 16372.83627163713, 12684.556040538537, 13127.474901003852, 13366.398512066786, 13442.0, 13715.862841371458, 13150.868491314965, 13415.865841341853, 13821.516246931309, 14133.081349712236, 14209.360578773772, 12791.0, 12933.805992909925, 12952.0, 13003.08978371505, 13161.736765264832, 8723.345749068973, 9009.23421509179, 9053.90946090557, 9092.363534552518, 9229.261659067393, 12737.681557961125, 13140.60578182656, 13215.207087574776, 13340.665383557645, 14001.649958751113], "unit": "ms", "name": "jquery.html", "value": 8179.916823869442}, {"lowerIsBetter": false, "replicates": [1347.7035052288493, 1352.4387379237617, 1397.133777058224, 1565.7651352297155, 1633.6405990682053, 6709.396154346108, 7049.682764275607, 7070.292970702927, 7097.396721278685, 7162.176349719777, 6985.441164706824, 6997.3002699730005, 7043.084399028119, 7047.964760176204, 7061.858762824753, 2040.8469364797663, 2066.1735305877696, 2068.338131797825, 2082.2816128435666, 2085.8852763098025, 2069.6791997240452, 2075.501879548905, 2094.3298144593737, 2114.3762590035976, 2115.3336698939784, 2023.9797602024012, 2069.3998740365278, 2069.896505174735, 2081.5212501124674, 2089.456741247279, 2026.0983862181336, 2045.3966080006435, 2048.846336524759, 2049.764277108137, 2050.8769473831544, 2064.370367038053, 2100.306898723418, 2103.758067822205, 2106.315447479575, 2112.9894350528302, 6822.215445223764, 6889.311068893121, 6931.549449285781, 6937.583744975318, 6964.756233531853, 3937.8818635440985, 3982.880513584597, 3995.5005624296964, 4000.5199376075057, 4004.6796256299426, 2730.8634568271705, 2736.7263273672675, 2805.5230610796216, 2823.8446885421295, 2828.8161269517414, 836.2390224895377, 837.7151768398774, 840.2941529115511, 846.1622993236651, 877.2630989968458, 9195.0, 9206.677766278215, 9234.307426943005, 9258.95370523143, 9266.16604505591, 3614.710823134143, 3667.504886840296, 3700.5559332880225, 3775.2638235543805, 3778.4899038629983, 7515.549067055994, 7584.2794934481135, 7586.203448637924, 7596.582187979604, 7623.656935437919, 3960.5841386653988, 3969.900752481211, 3974.0859602291057, 3975.045988962686, 3976.76139431635, 3573.4103872861206, 3614.8373323200517, 3615.801130937771, 3631.3463576556474, 3637.181634132299, 2979.865906034234, 3017.336186039068, 3047.7104675055834, 3049.60355153833, 3075.7539396848197, 922.9261659067258, 926.5598840550684, 931.106138107411, 931.464407965409, 934.5514153206364, 664.4551467796457, 665.4244078871741, 669.0733334331888, 669.4744625468984, 751.8984687432937, 6132.6627035513475, 6482.189726284215, 6484.286728459866, 6501.642409667419, 6514.739410423625, 852.9656768606793, 867.3754896474528, 867.6832955971025, 924.1867156902018, 1003.2525768302661, 5049.722265275372, 5075.0, 5111.46329635383, 5121.334226550524, 5137.33214682089, 8249.422540422112, 8348.081711011784, 8490.957545212234, 8556.657733690707, 8614.440061396115, 8402.285805706584, 8416.915830841614, 8458.915410845813, 8460.280876125475, 8491.702790402307, 6091.66495842724, 6170.907436388457, 6238.157848690369, 6252.937470625327, 6288.999999999908, 5810.564207684356, 5854.560907931837, 5866.6480011199465, 5882.176495290748, 5890.410958904075, 7164.749233776793, 7256.96371518139, 7353.852922941618, 7408.333250007525, 7432.293932076444, 7503.137139229058, 7538.208488108889, 7587.658555364911, 7697.345725613385, 7706.884396733942, 5655.7172141393585, 5663.85840353978, 5712.143178523254, 5740.68426236561, 5768.798092066758, 5974.551908606785, 6241.843953901007, 6345.333739957238, 6348.206474190726, 6366.808995730135, 5962.731677074629, 6125.0, 6182.289036760651, 6264.34224406449, 6277.12120303167, 5271.341082364705, 5935.376785437639, 5953.76184952597, 6094.329623741296, 6100.816975490742, 6006.519478441802, 6090.0, 6102.9694851525455, 6115.082737589397, 6215.533834962305, 5639.492445679744, 5676.801311954062, 5677.8864422710485, 5687.971560142173, 5692.48767610917, 5759.596828221985, 5833.4749872511675, 5838.649681019152, 5839.240898683314, 5845.09401042839], "unit": "ms", "name": "mootools.html", "value": 3870.461229432349}, {"lowerIsBetter": false, "replicates": [298.2499014977332, 301.4844615707141, 309.7661265744362, 310.1718411840386, 311.2172885193738, 5569.944300556993, 5645.237892884465, 5645.5483561314995, 5782.10377391504, 5794.362620111784, 5586.608937374385, 5651.2370829937945, 5652.604317697763, 5668.234788303578, 5669.319681638209, 4123.97938010311, 4228.492580890297, 4260.297050986584, 4277.187334406468, 4279.636230920375, 4251.192273468031, 4255.978720106411, 4262.041040765834, 4268.38108474271, 4274.29474136767, 4188.958110418903, 4217.704760666755, 4221.409002739619, 4236.110416812473, 4240.045989652334, 4226.598473145046, 4233.767142807144, 4237.703360764748, 4242.809073591665, 4244.787760611988, 3617.819109044537, 3635.0185449928636, 3647.252313275772, 3647.288778688157, 3666.5233519642543, 5295.205719142121, 5404.162354835007, 5443.863903402446, 5444.128939369722, 5462.399136095027, 4904.411470623512, 4913.484084171147, 4916.0, 4925.950740492585, 4926.778294976734, 5931.6441013539325, 5936.554758393095, 5938.673372964486, 5942.792002279943, 5951.345352011275, 3849.69202463805, 3994.1612261425134, 3998.5601583825755, 4017.7388469749667, 4024.0, 6136.877262454771, 6195.628262304276, 6219.40915613016, 6222.719977601018, 6228.532860035471, 4084.101497670508, 4087.3868919662286, 4095.8976025599004, 4096.836126554964, 4099.528554216304, 4145.502539695256, 4147.730397524151, 4165.083681590046, 4172.207280616673, 4174.895627609273, 4743.691660042086, 4772.49888761675, 4843.0313937211995, 4846.61227101831, 4847.757612119451, 5842.883142337129, 5880.970595147082, 5883.558733095035, 5884.558658100574, 5905.557083218776, 1469.977950330746, 1481.6073740458787, 1489.865912067919, 1490.5230326295482, 1490.9403623854923, 992.0674565908023, 992.2905122837207, 1005.8642083318805, 1010.2625083688948, 1010.4644538394663, 5120.487951204924, 5125.2568377585785, 5139.254808052811, 5150.459201783834, 5165.638405311667, 6105.267367915879, 6154.845803968575, 6155.4767844732805, 6157.0, 6158.568900176944, 5103.948960510422, 5115.462876397924, 5144.511271429208, 5151.665141765849, 5154.896902061938, 3224.3228921926657, 3261.2988207535495, 3289.523019162208, 3312.254742682877, 3334.1497918030745, 5760.0207964646115, 5814.476697097281, 5827.3298570664065, 5841.474267315962, 5849.736761845642, 6382.20222472191, 6385.2337719473035, 6391.169148010729, 6402.519811014193, 6405.135306733625, 5687.232223649837, 5760.36635970043, 5806.709664516758, 5827.3007239131575, 5842.386549412336, 6192.225971753531, 6193.628382296896, 6195.96902015487, 6197.535184861244, 6202.224721909762, 6026.548008899263, 6040.305364883095, 6048.5161187105805, 6059.969700151471, 6071.058985857199, 5687.488126068673, 5755.251817263729, 5822.388649191774, 5832.533397328289, 5833.387494313036, 4087.8569250076102, 4127.215828992482, 4135.813888375091, 4136.482939632546, 4146.212219678251, 5927.051671732502, 6066.787662431971, 6165.660888651168, 6168.599041062316, 6172.290186628596, 5817.592768506164, 5933.110033495011, 5933.436323549256, 5953.672548009901, 5968.746563221772, 5930.080837470199, 5931.08068249422, 5944.970275148597, 5945.732442040205, 5975.193348898017, 5658.462446067617, 5773.711314434346, 5813.94186058134, 5828.970855145697, 5831.8833623326445, 5932.6737029462065, 5962.16529685853, 5962.37395073511, 5968.970155149196, 5970.31341395745, 5781.508571771278, 5817.156512305776, 5827.125931110368, 5828.067509198508, 5849.093390524476], "unit": "ms", "name": "prototype.html", "value": 4397.562827780389}, {"lowerIsBetter": false, "replicates": [632.9050642403641, 655.9147310849589, 674.2650510943071, 730.466759265736, 753.7851712262004, 11246.943765281172, 11514.654560363182, 11523.13576481764, 11536.365499897502, 11552.942235288812, 11746.119041071912, 11750.529978800838, 11811.350375729331, 11828.822567661471, 11842.230255033417, 276.2568690223303, 279.830702425033, 735.0591243208702, 745.3813334931993, 752.2327226229243, 751.6054071612392, 758.0297219558973, 758.3364556013488, 762.3443838299058, 766.3026645752367, 796.5181065455403, 803.3091541274499, 803.9839203215932, 804.4770898915693, 805.5005896344275, 795.6578671171394, 799.2686691677137, 799.9560024198666, 800.5236884053978, 801.2988634944395, 594.3907494817803, 595.9165716799652, 596.1862058290445, 596.4661627843057, 597.7041364524545, 11277.266977646426, 11289.0, 11319.717007074807, 11398.658040258722, 11469.082473402108, 10497.265191436603, 10773.892261077368, 10857.294275872044, 10909.399983000932, 11006.174536909684, 8752.256058235058, 8951.283897288202, 9009.369344145913, 9154.588043538057, 9243.722688319362, 3178.904632861018, 3195.1532843796413, 3204.5513628092085, 3216.308493673848, 3236.1747754322496, 42291.36562951558, 42333.788331058146, 42633.360499592534, 42728.35907461391, 42737.0, 8878.600462979182, 8894.73315800527, 8912.242459390895, 8939.642414303486, 9019.413738107001, 16406.0, 16444.424445144363, 16478.588035299214, 16499.09254990987, 16611.252493637574, 6353.237611486558, 6434.0, 6495.188101487314, 6542.3130571290285, 6639.236487803964, 3316.585426821647, 3405.4210784166753, 3439.6044454887506, 3489.371913055674, 3515.3672338978718, 2633.4601406711963, 2655.774259187952, 2668.226214397803, 2670.399160188942, 2671.358873870296, 455.19430607823966, 463.76579827187055, 467.03557154475897, 472.7092837904664, 479.5516192360154, 528.822844347148, 544.9564034877201, 558.7625259264796, 572.5105035194931, 586.9941300587025, 7622.5426474411715, 7880.921190788019, 7938.960305198437, 8065.475744076616, 8177.182281771775, 455.0, 461.766807762078, 558.8239704493071, 594.521410264741, 601.5127746525328, 3591.0, 3670.632936706308, 3698.20488594948, 3776.8866933992026, 3870.4968354113785, 50730.0, 50788.0, 50974.235386469234, 50992.49007509877, 51229.231561526605, 43560.82195890193, 43665.34501982473, 43937.560624393984, 44319.335209971876, 44372.55627443684, 41353.586464134976, 42506.0, 42767.57232427698, 43900.0, 44316.55683443189, 7831.2560306770765, 7961.164077771982, 8045.316148127475, 8141.22658347456, 8246.546439945621, 32219.677803221668, 32484.675153248165, 32911.835440822644, 33446.16384590405, 33462.0, 41258.38112428376, 41492.79253603833, 41558.376624351265, 41720.58279417167, 41993.37009944792, 9085.54572271397, 9212.723618291462, 9511.143997040299, 9920.0, 9951.950240248752, 10759.569617215224, 10975.28660637056, 11013.83479247828, 11247.0, 11397.658070257905, 9642.084002019797, 9863.210943124677, 9905.851412228678, 10136.391816491034, 10573.52419141125, 9830.627029727704, 9911.553980071058, 10019.799604008025, 10028.64899728506, 10421.739456513647, 9294.628214871329, 9345.672901448417, 9712.902870971482, 10552.314099583502, 10703.785924281627, 8566.48601083912, 8598.78503037429, 8857.247133993425, 8877.778055548662, 8961.596728147118, 8579.35654825878, 8788.2529984952, 8809.11908809114, 8922.509261990654, 9086.136817002374], "unit": "ms", "name": "yui.html", "value": 5572.379360519878}], "name": "dromaeo_css", "value": 6221.678948555743}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 116.0, 113.0, 114.0, 125.0, 113.0, 113.0, 115.0, 114.0], "unit": "ms", "name": "ai-astar", "value": 114.4}, {"lowerIsBetter": true, "replicates": [160.0, 131.0, 159.0, 162.0, 135.0, 169.0, 154.0, 131.0, 169.0, 142.0], "unit": "ms", "name": "audio-beat-detection", "value": 151.2}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 163.0, 162.0, 162.0, 164.0, 167.0, 161.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 163.5}, {"lowerIsBetter": true, "replicates": [73.0, 76.0, 75.0, 74.0, 75.0, 72.0, 135.0, 73.0, 72.0, 76.0], "unit": "ms", "name": "audio-fft", "value": 80.1}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 133.0, 94.0, 95.0, 95.0, 133.0, 94.0, 96.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 106.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 111.0, 111.0, 110.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 110.3}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 148.0, 148.0, 149.0, 148.0, 147.0, 149.0, 147.0, 149.0], "unit": "ms", "name": "imaging-darkroom", "value": 148.0}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 97.0, 96.0, 96.0, 96.0, 97.0, 96.0, 97.0], "unit": "ms", "name": "imaging-desaturate", "value": 96.3}, {"lowerIsBetter": true, "replicates": [74.0, 74.0, 77.0, 78.0, 75.0, 73.0, 74.0, 74.0, 74.0, 72.0], "unit": "ms", "name": "json-parse-financial", "value": 74.5}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 69.0, 69.0, 70.0, 69.0, 69.0, 69.0, 71.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 85.0, 83.0, 83.0, 84.0, 84.0, 85.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [119.0, 130.0, 121.0, 126.0, 128.0, 132.0, 123.0, 126.0, 126.0, 134.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.5}, {"lowerIsBetter": true, "replicates": [139.0, 148.0, 146.0, 150.0, 152.0, 154.0, 148.0, 150.0, 146.0, 147.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 72.0, 72.0, 71.0, 68.0, 71.0, 72.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 70.7}], "name": "kraken", "value": 1542.8000000000002}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [173.79214459506431], "unit": "score", "name": "Richards", "value": 203.127708}, {"lowerIsBetter": false, "replicates": [184.1620626151013], "unit": "score", "name": "DeltaBlue", "value": 359.02074000000005}, {"lowerIsBetter": false, "replicates": [277.4694783573807], "unit": "score", "name": "Encrypt", "value": 959.316324}, {"lowerIsBetter": false, "replicates": [5229.166666666667], "unit": "score", "name": "Decrypt", "value": 50.90313944223106}, {"lowerIsBetter": false, "replicates": [1072.8831725616292], "unit": "score", "name": "RayTrace", "value": 689.7200169830171}, {"lowerIsBetter": false, "replicates": [706.2146892655368], "unit": "score", "name": "Earley", "value": 943.711608}, {"lowerIsBetter": false, "replicates": [12562.5], "unit": "score", "name": "Boyer", "value": 53.05178109452737}, {"lowerIsBetter": false, "replicates": [26153.846153846152], "unit": "score", "name": "RegExp", "value": 34.8317794117647}, {"lowerIsBetter": false, "replicates": [610.8735491753207], "unit": "score", "name": "Splay", "value": 133.40076699999995}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 21190.554207452227}]} 22:27:54 INFO - RETURN: dromaeo_css: 6221.68 22:27:54 INFO - RETURN: kraken: 1542.80 22:27:54 INFO - RETURN: v8_7: 21190.55 22:27:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,132,43]]", "result": "21190.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,132,43]]", "result": "1542.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,132,43]]", "result": "6221.68"}}} 22:27:54 INFO - Return code: 0 22:27:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:27:54 INFO - # TBPL SUCCESS # 22:27:54 INFO - Running post-action listener: _resource_record_post_action 22:27:54 INFO - Running post-run listener: _resource_record_post_run 22:27:55 INFO - Total resource usage - Wall time: 1230s; CPU: 13.0%; Read bytes: 0; Write bytes: 501559296; Read time: 0; Write time: 474456 22:27:55 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 225202176; Read time: 0; Write time: 291808 22:27:55 INFO - run-tests - Wall time: 1216s; CPU: 13.0%; Read bytes: 0; Write bytes: 276066304; Read time: 0; Write time: 182608 22:27:55 INFO - Running post-run listener: _upload_blobber_files 22:27:55 INFO - Blob upload gear active. 22:27:55 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:27:55 INFO - Copying logs to upload dir... 22:27:55 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1276.031049 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 16 secs) (at 2015-11-25 22:27:55.547438) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 22:27:55.551499) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009934 build_url: 'https://queue.taskcluster.net/v1/task/WP-bu1otRTiIh7NWxW-DmA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 22:27:55.577737) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:27:55.578160) ========= 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=7d909545e45784438f4e8e36000001b3-1448515954.158701-2140381322 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004562 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 22:27:55.628040) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 22:27:55.628364) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 22:27:55.628664) ========= ========= Total master_lag: 0.76 =========