builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-030 starttime: 1448452053.2 results: success (0) buildid: 20151125024330 builduid: a3f2ec9858b64212821e7b54c00087f6 revision: 0e4c4db3b90ff45937cc1eab4b7bbd61f4674326 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.201147) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.201846) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.202183) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006550 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.226022) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.226443) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.278219) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.278479) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004671 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.327214) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.327540) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.327988) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.328268) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 03:47:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 43.1M=0s 2015-11-25 03:47:33 (43.1 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.197594 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.538487) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.538912) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017655 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.589341) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:33.589684) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0e4c4db3b90ff45937cc1eab4b7bbd61f4674326 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 0e4c4db3b90ff45937cc1eab4b7bbd61f4674326 --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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 03:47:33,926 truncating revision to first 12 chars 2015-11-25 03:47:33,926 Setting DEBUG logging. 2015-11-25 03:47:33,926 attempt 1/10 2015-11-25 03:47:33,926 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/0e4c4db3b90f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 03:47:34,522 unpacking tar archive at: b2g-inbound-0e4c4db3b90f/testing/mozharness/ program finished with exit code 0 elapsedTime=0.889094 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:34.491557) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:34.491886) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:34.500877) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:34.501222) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 03:47:34.501685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-25 03:47:34.501965) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'B2G-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'B2G-Inbound-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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 03:47:34 INFO - MultiFileLogger online at 20151125 03:47:34 in /builds/slave/test 03:47:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 03:47:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:47:34 INFO - {'append_to_log': False, 03:47:34 INFO - 'base_work_dir': '/builds/slave/test', 03:47:34 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 03:47:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:47:34 INFO - 'branch': 'B2G-Inbound-Non-PGO', 03:47:34 INFO - 'buildbot_json_path': 'buildprops.json', 03:47:34 INFO - 'config_files': ('talos/linux_config.py',), 03:47:34 INFO - 'default_actions': ('clobber', 03:47:34 INFO - 'read-buildbot-config', 03:47:34 INFO - 'download-and-extract', 03:47:34 INFO - 'populate-webroot', 03:47:34 INFO - 'create-virtualenv', 03:47:34 INFO - 'install', 03:47:34 INFO - 'run-tests'), 03:47:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:47:34 INFO - 'download_minidump_stackwalk': True, 03:47:34 INFO - 'download_symbols': 'ondemand', 03:47:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:47:34 INFO - 'tooltool.py': '/tools/tooltool.py', 03:47:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:47:34 INFO - '/tools/misc-python/virtualenv.py')}, 03:47:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:47:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:47:34 INFO - 'installer_path': 'installer.exe', 03:47:34 INFO - 'log_level': 'info', 03:47:34 INFO - 'log_name': 'talos', 03:47:34 INFO - 'log_to_console': True, 03:47:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 03:47:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 03:47:34 INFO - 'opt_config_files': (), 03:47:34 INFO - 'pip_index': False, 03:47:34 INFO - 'sps_profile': False, 03:47:34 INFO - 'sps_profile_interval': 0, 03:47:34 INFO - 'suite': 'dromaeojs', 03:47:34 INFO - 'system_bits': '64', 03:47:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:47:34 INFO - 'title': 'talos-linux64-ix-030', 03:47:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:47:34 INFO - 'use_talos_json': True, 03:47:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:47:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:47:34 INFO - 'work_dir': 'build'} 03:47:34 INFO - ##### 03:47:34 INFO - ##### Running clobber step. 03:47:34 INFO - ##### 03:47:34 INFO - Running pre-action listener: _resource_record_pre_action 03:47:34 INFO - Running main action method: clobber 03:47:34 INFO - rmtree: /builds/slave/test/build 03:47:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:47:35 INFO - Running post-action listener: _resource_record_post_action 03:47:35 INFO - ##### 03:47:35 INFO - ##### Running read-buildbot-config step. 03:47:35 INFO - ##### 03:47:35 INFO - Running pre-action listener: _resource_record_pre_action 03:47:35 INFO - Running main action method: read_buildbot_config 03:47:35 INFO - Using buildbot properties: 03:47:35 INFO - { 03:47:35 INFO - "properties": { 03:47:35 INFO - "buildnumber": 287, 03:47:35 INFO - "product": "firefox", 03:47:35 INFO - "script_repo_revision": "production", 03:47:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 03:47:35 INFO - "repository": "", 03:47:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 03:47:35 INFO - "buildid": "20151125024330", 03:47:35 INFO - "slavename": "talos-linux64-ix-030", 03:47:35 INFO - "pgo_build": "False", 03:47:35 INFO - "basedir": "/builds/slave/test", 03:47:35 INFO - "project": "", 03:47:35 INFO - "platform": "ubuntu64_hw", 03:47:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 03:47:35 INFO - "slavebuilddir": "test", 03:47:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 03:47:35 INFO - "branch": "b2g-inbound", 03:47:35 INFO - "repo_path": "integration/b2g-inbound", 03:47:35 INFO - "stage_platform": "linux64", 03:47:35 INFO - "builduid": "a3f2ec9858b64212821e7b54c00087f6", 03:47:35 INFO - "revision": "0e4c4db3b90ff45937cc1eab4b7bbd61f4674326" 03:47:35 INFO - }, 03:47:35 INFO - "sourcestamp": { 03:47:35 INFO - "repository": "", 03:47:35 INFO - "hasPatch": false, 03:47:35 INFO - "project": "", 03:47:35 INFO - "branch": "b2g-inbound-linux64-talos", 03:47:35 INFO - "changes": [ 03:47:35 INFO - { 03:47:35 INFO - "category": null, 03:47:35 INFO - "files": [ 03:47:35 INFO - { 03:47:35 INFO - "url": null, 03:47:35 INFO - "name": "https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 03:47:35 INFO - } 03:47:35 INFO - ], 03:47:35 INFO - "repository": "", 03:47:35 INFO - "rev": "0e4c4db3b90ff45937cc1eab4b7bbd61f4674326", 03:47:35 INFO - "who": "yhuang@mozilla.com", 03:47:35 INFO - "when": 1448451996, 03:47:35 INFO - "number": 6705184, 03:47:35 INFO - "comments": "Bug 1209162 - Create OriginAttributes subtypes. IGNORE IDL r=sicking.", 03:47:35 INFO - "project": "", 03:47:35 INFO - "at": "Wed 25 Nov 2015 03:46:36", 03:47:35 INFO - "branch": "b2g-inbound-linux64-talos", 03:47:35 INFO - "revlink": "", 03:47:35 INFO - "properties": [ 03:47:35 INFO - [ 03:47:35 INFO - "buildid", 03:47:35 INFO - "20151125024330", 03:47:35 INFO - "Change" 03:47:35 INFO - ], 03:47:35 INFO - [ 03:47:35 INFO - "builduid", 03:47:35 INFO - "a3f2ec9858b64212821e7b54c00087f6", 03:47:35 INFO - "Change" 03:47:35 INFO - ], 03:47:35 INFO - [ 03:47:35 INFO - "pgo_build", 03:47:35 INFO - "False", 03:47:35 INFO - "Change" 03:47:35 INFO - ] 03:47:35 INFO - ], 03:47:35 INFO - "revision": "0e4c4db3b90ff45937cc1eab4b7bbd61f4674326" 03:47:35 INFO - } 03:47:35 INFO - ], 03:47:35 INFO - "revision": "0e4c4db3b90ff45937cc1eab4b7bbd61f4674326" 03:47:35 INFO - } 03:47:35 INFO - } 03:47:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 03:47:35 INFO - Running post-action listener: _resource_record_post_action 03:47:35 INFO - ##### 03:47:35 INFO - ##### Running download-and-extract step. 03:47:35 INFO - ##### 03:47:35 INFO - Running pre-action listener: _resource_record_pre_action 03:47:35 INFO - Running main action method: download_and_extract 03:47:35 INFO - mkdir: /builds/slave/test/build/tests 03:47:35 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')]} 03:47:35 INFO - https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 03:47:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/test_packages.json 03:47:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/test_packages.json 03:47:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 03:47:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 03:47:39 INFO - Downloaded 1302 bytes. 03:47:39 INFO - Reading from file /builds/slave/test/build/test_packages.json 03:47:39 INFO - Using the following test package requirements: 03:47:39 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:39 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 03:47:39 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'jsshell-linux-x86_64.zip'], 03:47:39 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 03:47:39 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:39 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 03:47:39 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 03:47:39 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 03:47:39 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 03:47:39 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 03:47:39 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 03:47:39 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 03:47: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')]} 03:47:39 INFO - https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:40 INFO - Downloaded 21345618 bytes. 03:47:40 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 03:47:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:40 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 03:47:41 INFO - Return code: 0 03:47:41 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 03:47:41 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')]} 03:47:41 INFO - https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 03:47:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:43 INFO - Downloaded 21345618 bytes. 03:47:43 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 03:47:43 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 03:47:43 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 03:47:44 INFO - Return code: 0 03:47:44 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')]} 03:47:44 INFO - https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 03:47:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:45 INFO - Downloaded 11131717 bytes. 03:47:45 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 03:47:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 03:47:45 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 03:47:45 INFO - Return code: 0 03:47:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:45 INFO - https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 03:47:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/aA98hS3OTwifx9dqT9JFSg/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 03:47:47 INFO - Downloaded 56848272 bytes. 03:47:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:47 INFO - mkdir: /builds/slave/test/properties 03:47:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:47:47 INFO - Writing to file /builds/slave/test/properties/build_url 03:47:47 INFO - Contents: 03:47:47 INFO - build_url:https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 03:47:47 INFO - Running post-action listener: _resource_record_post_action 03:47:47 INFO - Running post-action listener: set_extra_try_arguments 03:47:47 INFO - ##### 03:47:47 INFO - ##### Running populate-webroot step. 03:47:47 INFO - ##### 03:47:47 INFO - Running pre-action listener: _resource_record_pre_action 03:47:47 INFO - Running main action method: populate_webroot 03:47:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:47:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:47:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 03:47:47 INFO - '../fennec_ids.txt'], 03:47:47 INFO - 'tests': ['tcheck2']}, 03:47:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:47:47 INFO - '--tppagecycles', 03:47:47 INFO - '7'], 03:47:47 INFO - 'tests': ['tsvgm']}}, 03:47:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 03:47:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:47:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 03:47:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:47:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'tests': ['damp', 'tps']}, 03:47:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['damp', 'tps']}, 03:47:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 03:47:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:47:47 INFO - 'other': {'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'other_l64': {'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'other_nol64': {'tests': ['a11yr', 03:47:47 INFO - 'ts_paint', 03:47:47 INFO - 'tpaint', 03:47:47 INFO - 'sessionrestore', 03:47:47 INFO - 'sessionrestore_no_auto_restore']}, 03:47:47 INFO - 'svgr': {'tests': ['tsvgx', 03:47:47 INFO - 'tsvgr_opacity', 03:47:47 INFO - 'tart', 03:47:47 INFO - 'tscrollx', 03:47:47 INFO - 'cart']}, 03:47:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['tsvgx', 03:47:47 INFO - 'tsvgr_opacity', 03:47:47 INFO - 'tart', 03:47:47 INFO - 'tscrollx', 03:47:47 INFO - 'cart']}, 03:47:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'tests': ['tp5o']}, 03:47:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'talos_options': ['--e10s'], 03:47:47 INFO - 'tests': ['tp5o']}, 03:47:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'talos_options': ['--xperf_path', 03:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:47 INFO - 'tests': ['tp5n']}, 03:47:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 03:47:47 INFO - 'talos_options': ['--e10s', 03:47:47 INFO - '--xperf_path', 03:47:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:47:47 INFO - 'tests': ['tp5n']}}, 03:47:47 INFO - 'talos.zip': {'path': '', 03:47:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:47:47 INFO - Running post-action listener: _resource_record_post_action 03:47:47 INFO - ##### 03:47:47 INFO - ##### Running create-virtualenv step. 03:47:47 INFO - ##### 03:47:47 INFO - Running pre-action listener: _resource_record_pre_action 03:47:47 INFO - Running main action method: create_virtualenv 03:47:47 INFO - Creating virtualenv /builds/slave/test/build/venv 03:47:47 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 03:47:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:47:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:47:47 INFO - Using real prefix '/usr' 03:47:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:47:48 INFO - Installing distribute.............................................................................................................................................................................................done. 03:47:50 INFO - Installing pip.................done. 03:47:50 INFO - Return code: 0 03:47:50 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:47:50 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 03:47:50 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 03:47:50 INFO - Using env: {'DISPLAY': ':0', 03:47:50 INFO - 'HOME': '/home/cltbld', 03:47:50 INFO - 'LANG': 'en_US.UTF-8', 03:47:50 INFO - 'LANGUAGE': 'en_US:en', 03:47:50 INFO - 'LOGNAME': 'cltbld', 03:47:50 INFO - 'MAIL': '/var/mail/cltbld', 03:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:50 INFO - 'MOZ_NO_REMOTE': '1', 03:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:50 INFO - 'NO_EM_RESTART': '1', 03:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:50 INFO - 'PWD': '/builds/slave/test', 03:47:50 INFO - 'SHELL': '/bin/bash', 03:47:50 INFO - 'SHLVL': '1', 03:47:50 INFO - 'TERM': 'linux', 03:47:50 INFO - 'TMOUT': '86400', 03:47:50 INFO - 'USER': 'cltbld', 03:47:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:50 INFO - '_': '/tools/buildbot/bin/python'} 03:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:50 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 03:47:50 INFO - Cleaning up... 03:47:50 INFO - Return code: 0 03:47:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:50 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:47:50 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 03:47:50 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 03:47:50 INFO - Using env: {'DISPLAY': ':0', 03:47:50 INFO - 'HOME': '/home/cltbld', 03:47:50 INFO - 'LANG': 'en_US.UTF-8', 03:47:50 INFO - 'LANGUAGE': 'en_US:en', 03:47:50 INFO - 'LOGNAME': 'cltbld', 03:47:50 INFO - 'MAIL': '/var/mail/cltbld', 03:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:50 INFO - 'MOZ_NO_REMOTE': '1', 03:47:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:50 INFO - 'NO_EM_RESTART': '1', 03:47:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:50 INFO - 'PWD': '/builds/slave/test', 03:47:50 INFO - 'SHELL': '/bin/bash', 03:47:50 INFO - 'SHLVL': '1', 03:47:50 INFO - 'TERM': 'linux', 03:47:50 INFO - 'TMOUT': '86400', 03:47:50 INFO - 'USER': 'cltbld', 03:47:50 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:50 INFO - '_': '/tools/buildbot/bin/python'} 03:47:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:50 INFO - Downloading/unpacking psutil>=0.7.1 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 03:47:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 03:47:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:52 INFO - Installing collected packages: psutil 03:47:52 INFO - Running setup.py install for psutil 03:47:52 INFO - building 'psutil._psutil_linux' extension 03:47:52 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 03:47:52 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 03:47:52 INFO - building 'psutil._psutil_posix' extension 03:47:52 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 03:47:52 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 03:47:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:47:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:47:52 INFO - Successfully installed psutil 03:47:52 INFO - Cleaning up... 03:47:52 INFO - Return code: 0 03:47:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 03:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:47:52 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 03:47:52 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 03:47:52 INFO - Using env: {'DISPLAY': ':0', 03:47:52 INFO - 'HOME': '/home/cltbld', 03:47:52 INFO - 'LANG': 'en_US.UTF-8', 03:47:52 INFO - 'LANGUAGE': 'en_US:en', 03:47:52 INFO - 'LOGNAME': 'cltbld', 03:47:52 INFO - 'MAIL': '/var/mail/cltbld', 03:47:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:52 INFO - 'MOZ_NO_REMOTE': '1', 03:47:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:52 INFO - 'NO_EM_RESTART': '1', 03:47:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:52 INFO - 'PWD': '/builds/slave/test', 03:47:52 INFO - 'SHELL': '/bin/bash', 03:47:52 INFO - 'SHLVL': '1', 03:47:52 INFO - 'TERM': 'linux', 03:47:52 INFO - 'TMOUT': '86400', 03:47:52 INFO - 'USER': 'cltbld', 03:47:52 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:47:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:52 INFO - '_': '/tools/buildbot/bin/python'} 03:47:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:53 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 03:47:53 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 03:47:53 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 03:47:53 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 03:47:53 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 03:47:53 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 03:47:53 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 03:47:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 03:47:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 03:47:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:47:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 03:47:54 INFO - Installing collected packages: mozsystemmonitor 03:47:54 INFO - Running setup.py install for mozsystemmonitor 03:47:54 INFO - Successfully installed mozsystemmonitor 03:47:54 INFO - Cleaning up... 03:47:55 INFO - Return code: 0 03:47:55 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:55 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:47:55 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 03:47:55 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 03:47:55 INFO - Using env: {'DISPLAY': ':0', 03:47:55 INFO - 'HOME': '/home/cltbld', 03:47:55 INFO - 'LANG': 'en_US.UTF-8', 03:47:55 INFO - 'LANGUAGE': 'en_US:en', 03:47:55 INFO - 'LOGNAME': 'cltbld', 03:47:55 INFO - 'MAIL': '/var/mail/cltbld', 03:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:55 INFO - 'MOZ_NO_REMOTE': '1', 03:47:55 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:55 INFO - 'NO_EM_RESTART': '1', 03:47:55 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:55 INFO - 'PWD': '/builds/slave/test', 03:47:55 INFO - 'SHELL': '/bin/bash', 03:47:55 INFO - 'SHLVL': '1', 03:47:55 INFO - 'TERM': 'linux', 03:47:55 INFO - 'TMOUT': '86400', 03:47:55 INFO - 'USER': 'cltbld', 03:47:55 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:55 INFO - '_': '/tools/buildbot/bin/python'} 03:47:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:55 INFO - Downloading/unpacking blobuploader==1.2.4 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:47:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:47:56 INFO - Downloading blobuploader-1.2.4.tar.gz 03:47:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 03:47:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:47:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:47:56 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 03:47:56 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 03:47:56 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 03:47:56 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 03:47:56 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 03:47:56 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 03:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 03:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:47:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:47:57 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 03:47:57 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 03:47:57 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 03:47:57 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 03:47:57 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 03:47:57 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 03:47:57 INFO - Downloading docopt-0.6.1.tar.gz 03:47:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 03:47:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:47:57 INFO - Installing collected packages: blobuploader, requests, docopt 03:47:57 INFO - Running setup.py install for blobuploader 03:47:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:47:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:47:57 INFO - Running setup.py install for requests 03:47:58 INFO - Running setup.py install for docopt 03:47:58 INFO - Successfully installed blobuploader requests docopt 03:47:58 INFO - Cleaning up... 03:47:58 INFO - Return code: 0 03:47:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:47: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')]} 03:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47: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')]} 03:47:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:47:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:47:58 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:47:58 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 03:47:58 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 03:47:58 INFO - Using env: {'DISPLAY': ':0', 03:47:58 INFO - 'HOME': '/home/cltbld', 03:47:58 INFO - 'LANG': 'en_US.UTF-8', 03:47:58 INFO - 'LANGUAGE': 'en_US:en', 03:47:58 INFO - 'LOGNAME': 'cltbld', 03:47:58 INFO - 'MAIL': '/var/mail/cltbld', 03:47:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:47:58 INFO - 'MOZ_NO_REMOTE': '1', 03:47:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:47:58 INFO - 'NO_EM_RESTART': '1', 03:47:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:47:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:47:58 INFO - 'PWD': '/builds/slave/test', 03:47:58 INFO - 'SHELL': '/bin/bash', 03:47:58 INFO - 'SHLVL': '1', 03:47:58 INFO - 'TERM': 'linux', 03:47:58 INFO - 'TMOUT': '86400', 03:47:58 INFO - 'USER': 'cltbld', 03:47:58 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:47:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:47:58 INFO - '_': '/tools/buildbot/bin/python'} 03:47:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:47:58 INFO - Running setup.py (path:/tmp/pip-r0i1sq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:47:58 INFO - Running setup.py (path:/tmp/pip-J90SDT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:47:58 INFO - Running setup.py (path:/tmp/pip-DJGg9z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:47:58 INFO - Running setup.py (path:/tmp/pip-v63ual-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:47:58 INFO - Running setup.py (path:/tmp/pip-sQx07p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:47:58 INFO - Running setup.py (path:/tmp/pip-C6yYgL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:47:58 INFO - Running setup.py (path:/tmp/pip-CvGlEx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:47:58 INFO - Running setup.py (path:/tmp/pip-rHUyL_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:47:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:47:58 INFO - Running setup.py (path:/tmp/pip-5xUTte-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:47:59 INFO - Running setup.py (path:/tmp/pip-kpnfEl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:47:59 INFO - Running setup.py (path:/tmp/pip-ya7fs3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:47:59 INFO - Running setup.py (path:/tmp/pip-8pbe_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:47:59 INFO - Running setup.py (path:/tmp/pip-9RA484-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:47:59 INFO - Running setup.py (path:/tmp/pip-aSEuay-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:59 INFO - Running setup.py (path:/tmp/pip-4ujWXC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:47:59 INFO - Running setup.py (path:/tmp/pip-XjhWuQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:47:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:47:59 INFO - Running setup.py (path:/tmp/pip-JWWxcY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:47:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:47:59 INFO - Running setup.py install for manifestparser 03:47:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:47:59 INFO - Running setup.py install for mozcrash 03:47:59 INFO - Running setup.py install for mozdebug 03:47:59 INFO - Running setup.py install for mozdevice 03:48:00 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozfile 03:48:00 INFO - Running setup.py install for mozhttpd 03:48:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozinfo 03:48:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozInstall 03:48:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozleak 03:48:00 INFO - Running setup.py install for mozlog 03:48:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for moznetwork 03:48:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozprocess 03:48:00 INFO - Running setup.py install for mozprofile 03:48:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:48:00 INFO - Running setup.py install for mozrunner 03:48:01 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:48:01 INFO - Running setup.py install for mozscreenshot 03:48:01 INFO - Running setup.py install for moztest 03:48:01 INFO - Running setup.py install for mozversion 03:48:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:48:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:48:01 INFO - Cleaning up... 03:48:01 INFO - Return code: 0 03:48:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:01 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')]} 03:48:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:01 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')]} 03:48:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:01 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:48:01 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 03:48:01 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 03:48:01 INFO - Using env: {'DISPLAY': ':0', 03:48:01 INFO - 'HOME': '/home/cltbld', 03:48:01 INFO - 'LANG': 'en_US.UTF-8', 03:48:01 INFO - 'LANGUAGE': 'en_US:en', 03:48:01 INFO - 'LOGNAME': 'cltbld', 03:48:01 INFO - 'MAIL': '/var/mail/cltbld', 03:48:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:01 INFO - 'MOZ_NO_REMOTE': '1', 03:48:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:01 INFO - 'NO_EM_RESTART': '1', 03:48:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:01 INFO - 'PWD': '/builds/slave/test', 03:48:01 INFO - 'SHELL': '/bin/bash', 03:48:01 INFO - 'SHLVL': '1', 03:48:01 INFO - 'TERM': 'linux', 03:48:01 INFO - 'TMOUT': '86400', 03:48:01 INFO - 'USER': 'cltbld', 03:48:01 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:48:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:01 INFO - '_': '/tools/buildbot/bin/python'} 03:48:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:48:01 INFO - Running setup.py (path:/tmp/pip-eLIJKE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:48:01 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)) 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:48:01 INFO - Running setup.py (path:/tmp/pip-_4BjXI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:48:01 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)) 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:48:01 INFO - Running setup.py (path:/tmp/pip-ZhYfJI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:48:01 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)) 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:48:01 INFO - Running setup.py (path:/tmp/pip-Sb8qZp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:48:01 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)) 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:48:01 INFO - Running setup.py (path:/tmp/pip-IMRBUi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:48:01 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)) 03:48:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:48:01 INFO - Running setup.py (path:/tmp/pip-j3GA7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:48:02 INFO - Running setup.py (path:/tmp/pip-7lO8AX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:48:02 INFO - Running setup.py (path:/tmp/pip-ZSZ4gX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:48:02 INFO - Running setup.py (path:/tmp/pip-80vZ3K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:48:02 INFO - Running setup.py (path:/tmp/pip-GZ8Ado-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:48:02 INFO - Running setup.py (path:/tmp/pip-gZvpFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:48:02 INFO - Running setup.py (path:/tmp/pip-kG20RI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:48:02 INFO - Running setup.py (path:/tmp/pip-U5zuzK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:48:02 INFO - Running setup.py (path:/tmp/pip-2zRNl2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 INFO - Running setup.py (path:/tmp/pip-sv6saY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:48:02 INFO - Running setup.py (path:/tmp/pip-IlH4Jm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:48:02 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)) 03:48:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:48:02 INFO - Running setup.py (path:/tmp/pip-rz2zDl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:48:02 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)) 03:48:02 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)) 03:48:02 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)) 03:48:02 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)) 03:48:02 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)) 03:48:02 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)) 03:48:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:04 INFO - Downloading blessings-1.5.1.tar.gz 03:48:04 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 03:48:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:48:04 INFO - Installing collected packages: blessings 03:48:04 INFO - Running setup.py install for blessings 03:48:04 INFO - Successfully installed blessings 03:48:04 INFO - Cleaning up... 03:48:04 INFO - Return code: 0 03:48:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:04 INFO - Reading from file tmpfile_stdout 03:48:04 INFO - Current package versions: 03:48:04 INFO - argparse == 1.2.1 03:48:04 INFO - blessings == 1.5.1 03:48:04 INFO - blobuploader == 1.2.4 03:48:04 INFO - docopt == 0.6.1 03:48:04 INFO - manifestparser == 1.1 03:48:04 INFO - mozInstall == 1.12 03:48:04 INFO - mozcrash == 0.16 03:48:04 INFO - mozdebug == 0.1 03:48:04 INFO - mozdevice == 0.47 03:48:04 INFO - mozfile == 1.2 03:48:04 INFO - mozhttpd == 0.7 03:48:04 INFO - mozinfo == 0.9 03:48:04 INFO - mozleak == 0.1 03:48:04 INFO - mozlog == 3.1 03:48:04 INFO - moznetwork == 0.27 03:48:04 INFO - mozprocess == 0.22 03:48:04 INFO - mozprofile == 0.27 03:48:04 INFO - mozrunner == 6.11 03:48:04 INFO - mozscreenshot == 0.1 03:48:04 INFO - mozsystemmonitor == 0.0 03:48:04 INFO - moztest == 0.7 03:48:04 INFO - mozversion == 1.4 03:48:04 INFO - psutil == 3.1.1 03:48:04 INFO - requests == 1.2.3 03:48:04 INFO - wsgiref == 0.1.2 03:48:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:48:04 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')]} 03:48:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:04 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')]} 03:48:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:04 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 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:48:04 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 03:48:04 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 03:48:04 INFO - Using env: {'DISPLAY': ':0', 03:48:04 INFO - 'HOME': '/home/cltbld', 03:48:04 INFO - 'LANG': 'en_US.UTF-8', 03:48:04 INFO - 'LANGUAGE': 'en_US:en', 03:48:04 INFO - 'LOGNAME': 'cltbld', 03:48:04 INFO - 'MAIL': '/var/mail/cltbld', 03:48:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:04 INFO - 'MOZ_NO_REMOTE': '1', 03:48:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:04 INFO - 'NO_EM_RESTART': '1', 03:48:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:04 INFO - 'PWD': '/builds/slave/test', 03:48:04 INFO - 'SHELL': '/bin/bash', 03:48:04 INFO - 'SHLVL': '1', 03:48:04 INFO - 'TERM': 'linux', 03:48:04 INFO - 'TMOUT': '86400', 03:48:04 INFO - 'USER': 'cltbld', 03:48:04 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:48:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:04 INFO - '_': '/tools/buildbot/bin/python'} 03:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 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)) 03:48:05 INFO - Cleaning up... 03:48:05 INFO - Return code: 0 03:48:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 03:48:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:48:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:48:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1fd0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x21328a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2201210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, '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': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', '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 03:48:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 03:48:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 03:48:05 INFO - Using env: {'DISPLAY': ':0', 03:48:05 INFO - 'HOME': '/home/cltbld', 03:48:05 INFO - 'LANG': 'en_US.UTF-8', 03:48:05 INFO - 'LANGUAGE': 'en_US:en', 03:48:05 INFO - 'LOGNAME': 'cltbld', 03:48:05 INFO - 'MAIL': '/var/mail/cltbld', 03:48:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:05 INFO - 'MOZ_NO_REMOTE': '1', 03:48:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:05 INFO - 'NO_EM_RESTART': '1', 03:48:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:05 INFO - 'PWD': '/builds/slave/test', 03:48:05 INFO - 'SHELL': '/bin/bash', 03:48:05 INFO - 'SHLVL': '1', 03:48:05 INFO - 'TERM': 'linux', 03:48:05 INFO - 'TMOUT': '86400', 03:48:05 INFO - 'USER': 'cltbld', 03:48:05 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:48:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:05 INFO - '_': '/tools/buildbot/bin/python'} 03:48:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:48:05 INFO - Downloading/unpacking jsonschema 03:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:48:07 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 03:48:07 INFO - Downloading/unpacking functools32 (from jsonschema) 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:48:07 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:48:07 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:48:07 INFO - Downloading functools32-3.2.3-2.tar.gz 03:48:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Ffunctools32-3.2.3-2.tar.gz 03:48:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:48:07 INFO - warning: no files found matching '*.txt' 03:48:07 INFO - no previously-included directories found matching 'build' 03:48:07 INFO - no previously-included directories found matching 'dist' 03:48:07 INFO - no previously-included directories found matching '.git*' 03:48:07 INFO - Installing collected packages: jsonschema, functools32 03:48:07 INFO - Running setup.py install for functools32 03:48:07 INFO - warning: no files found matching '*.txt' 03:48:07 INFO - no previously-included directories found matching 'build' 03:48:07 INFO - no previously-included directories found matching 'dist' 03:48:07 INFO - no previously-included directories found matching '.git*' 03:48:07 INFO - Successfully installed jsonschema functools32 03:48:07 INFO - Cleaning up... 03:48:07 INFO - Return code: 0 03:48:07 INFO - Running post-action listener: _resource_record_post_action 03:48:07 INFO - Running post-action listener: _start_resource_monitoring 03:48:07 INFO - Starting resource monitoring. 03:48:07 INFO - ##### 03:48:07 INFO - ##### Running install step. 03:48:07 INFO - ##### 03:48:07 INFO - Running pre-action listener: _resource_record_pre_action 03:48:07 INFO - Running main action method: install 03:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:48:07 INFO - Reading from file tmpfile_stdout 03:48:07 INFO - Detecting whether we're running mozinstall >=1.0... 03:48:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:48:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:48:07 INFO - Reading from file tmpfile_stdout 03:48:07 INFO - Output received: 03:48:07 INFO - Usage: mozinstall [options] installer 03:48:07 INFO - Options: 03:48:07 INFO - -h, --help show this help message and exit 03:48:07 INFO - -d DEST, --destination=DEST 03:48:07 INFO - Directory to install application into. [default: 03:48:07 INFO - "/builds/slave/test"] 03:48:07 INFO - --app=APP Application being installed. [default: firefox] 03:48:07 INFO - mkdir: /builds/slave/test/build/application 03:48:07 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'] 03:48:07 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 03:48:22 INFO - Reading from file tmpfile_stdout 03:48:22 INFO - Output received: 03:48:22 INFO - /builds/slave/test/build/application/firefox/firefox 03:48:22 INFO - Running post-action listener: _resource_record_post_action 03:48:22 INFO - ##### 03:48:22 INFO - ##### Running run-tests step. 03:48:22 INFO - ##### 03:48:22 INFO - Running pre-action listener: _resource_record_pre_action 03:48:22 INFO - Running main action method: run_tests 03:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:48:22 INFO - Python 2.7.3 03:48:22 INFO - Return code: 0 03:48:22 INFO - grabbing minidump binary from tooltool 03:48:22 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')]} 03:48:22 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 0x2293220>, '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 0x21ff2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x21ff740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:48:22 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 03:48:22 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 03:48:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:48:22 INFO - Return code: 0 03:48:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 03:48:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:48:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:48:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 03:48:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:48:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] in /builds/slave/test/build 03:48:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-030 --webServer localhost 03:48:22 INFO - Using env: {'DISPLAY': ':0', 03:48:22 INFO - 'HOME': '/home/cltbld', 03:48:22 INFO - 'LANG': 'en_US.UTF-8', 03:48:22 INFO - 'LANGUAGE': 'en_US:en', 03:48:22 INFO - 'LOGNAME': 'cltbld', 03:48:22 INFO - 'MAIL': '/var/mail/cltbld', 03:48:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:48:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 03:48:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:48:22 INFO - 'MOZ_NO_REMOTE': '1', 03:48:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:48:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 03:48:22 INFO - 'NO_EM_RESTART': '1', 03:48:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 03:48:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:48:22 INFO - 'PWD': '/builds/slave/test', 03:48:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:48:22 INFO - 'SHELL': '/bin/bash', 03:48:22 INFO - 'SHLVL': '1', 03:48:22 INFO - 'TERM': 'linux', 03:48:22 INFO - 'TMOUT': '86400', 03:48:22 INFO - 'USER': 'cltbld', 03:48:22 INFO - 'XDG_SESSION_COOKIE': '23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312', 03:48:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:48:22 INFO - '_': '/tools/buildbot/bin/python'} 03:48:22 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-030', '--webServer', 'localhost'] with output_timeout 3600 03:48:22 INFO - mozversion INFO | application_buildid: 20151125024330 03:48:22 INFO - mozversion INFO | application_changeset: 0e4c4db3b90ff45937cc1eab4b7bbd61f4674326 03:48:22 INFO - mozversion INFO | application_display_name: Nightly 03:48:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:48:22 INFO - mozversion INFO | application_name: Firefox 03:48:22 INFO - mozversion INFO | application_remotingname: firefox 03:48:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 03:48:22 INFO - mozversion INFO | application_vendor: Mozilla 03:48:22 INFO - mozversion INFO | application_version: 45.0a1 03:48:22 INFO - mozversion INFO | platform_buildid: 20151125024330 03:48:22 INFO - mozversion INFO | platform_changeset: 0e4c4db3b90ff45937cc1eab4b7bbd61f4674326 03:48:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 03:48:22 INFO - mozversion INFO | platform_version: 45.0a1 03:48:22 INFO - 2015-11-25 03:48:22,440 DEBUG : using testdate: 1448452102 03:48:22 INFO - 2015-11-25 03:48:22,440 DEBUG : actual date: 1448452102 03:48:22 INFO - 2015-11-25 03:48:22,451 INFO : starting webserver on 'localhost:45362' 03:48:22 INFO - 2015-11-25 03:48:22,452 INFO : Starting test suite talos-linux64-ix-030 03:48:22 INFO - 2015-11-25 03:48:22,452 INFO : Starting test dromaeo_css 03:48:22 INFO - 2015-11-25 03:48:22,452 DEBUG : operating with platform_type : linux_ 03:48:22 INFO - 2015-11-25 03:48:22,453 INFO : Initialising browser for dromaeo_css test... 03:48:22 INFO - 2015-11-25 03:48:22,469 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfdjwWM/profile http://localhost:45362/getInfo.html 03:48:26 INFO - 2015-11-25 03:48:26,531 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 03:48:26 INFO - 2015-11-25 03:48:26,531 DEBUG : BROWSER_OUTPUT: colorDepth:24 03:48:26 INFO - 2015-11-25 03:48:26,531 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 03:48:26 INFO - 2015-11-25 03:48:26,531 DEBUG : BROWSER_OUTPUT: __metrics 03:48:26 INFO - 2015-11-25 03:48:26,716 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:48:27 INFO - 2015-11-25 03:48:27,938 INFO : Browser initialized. 03:48:27 INFO - 2015-11-25 03:48:27,939 INFO : Running cycle 1/1 for dromaeo_css test... 03:48:27 INFO - 2015-11-25 03:48:27,939 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpfdjwWM/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 03:48:39 INFO - 2015-11-25 03:48:39,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 139366400 03:48:39 INFO - 2015-11-25 03:48:39,717 DEBUG : BROWSER_OUTPUT: 03:49:30 INFO - 2015-11-25 03:49:30,909 DEBUG : BROWSER_OUTPUT: 1448452170908 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] 03:51:43 INFO - 2015-11-25 03:51:43,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-dojo.html (next: http://localhost:45362/tests/dromaeo/cssquery-ext.html) 03:51:44 INFO - 2015-11-25 03:51:44,262 DEBUG : BROWSER_OUTPUT: RSS: Main: 243134464 03:51:44 INFO - 2015-11-25 03:51:44,263 DEBUG : BROWSER_OUTPUT: 03:54:46 INFO - 2015-11-25 03:54:46,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-ext.html (next: http://localhost:45362/tests/dromaeo/cssquery-jquery.html) 03:54:47 INFO - 2015-11-25 03:54:47,487 DEBUG : BROWSER_OUTPUT: RSS: Main: 224481280 03:54:47 INFO - 2015-11-25 03:54:47,487 DEBUG : BROWSER_OUTPUT: 03:57:49 INFO - 2015-11-25 03:57:49,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-jquery.html (next: http://localhost:45362/tests/dromaeo/cssquery-mootools.html) 03:57:50 INFO - 2015-11-25 03:57:50,169 DEBUG : BROWSER_OUTPUT: RSS: Main: 217972736 03:57:50 INFO - 2015-11-25 03:57:50,169 DEBUG : BROWSER_OUTPUT: 04:00:52 INFO - 2015-11-25 04:00:52,049 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-mootools.html (next: http://localhost:45362/tests/dromaeo/cssquery-prototype.html) 04:00:52 INFO - 2015-11-25 04:00:52,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 205357056 04:00:52 INFO - 2015-11-25 04:00:52,619 DEBUG : BROWSER_OUTPUT: 04:03:55 INFO - 2015-11-25 04:03:55,411 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-prototype.html (next: http://localhost:45362/tests/dromaeo/cssquery-yui.html) 04:03:55 INFO - 2015-11-25 04:03:55,993 DEBUG : BROWSER_OUTPUT: RSS: Main: 208179200 04:03:55 INFO - 2015-11-25 04:03:55,993 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,496 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/dromaeo/cssquery-yui.html (next: http://localhost:45362/tests/dromaeo/cssquery-dojo.html) 04:06:58 INFO - 2015-11-25 04:06:58,747 DEBUG : BROWSER_OUTPUT: RSS: Main: 254181376 04:06:58 INFO - 2015-11-25 04:06:58,747 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,748 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:06:58 INFO - 2015-11-25 04:06:58,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:06:58 INFO - 2015-11-25 04:06:58,748 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:06:58 INFO - 2015-11-25 04:06:58,748 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:06:58 INFO - 2015-11-25 04:06:58,749 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2663.8934442622294;2728.372474330904;2738.83566985981;2752.133078080406;2753.352962053917;4613.9538604613945;4701.200795864703;4735.502772208912;4755.738434386111;4782.043591281745;4678.976605116978;4710.481846996828;4720.59874910633;4839.15314819906;4854.708717476954;4278.807453664593;4343.522212556616;4354.063876266602;4373.671974601902;4438.600525952664;4401.405810215628;4445.066536027438;4456.777161141946;4503.234450143484;4508.77456127194;4232.449781528412;4340.674449416275;4487.640988720895;4521.118381915528;4525.909481810362;4306.935395969063;4330.870073897788;4338.045629961403;4341.934870976938;4344.348347747831;4327.502337231227;4331.7617531035785;4331.891702707426;4338.284183109815;4339.978300108511;4587.9082418351445;4677.321788340671;4698.7650617469335;4700.929486057712;4718.4809670936165;5082.263071854597;5126.6923984561045;5130.050940576006;5142.717150556718;5183.714895680736;4850.854474365775;4971.080350135237;5151.072806894795;5164.92252616211;5168.508991645787;4621.514740952185;4685.718856868633;4754.334393184957;4759.6668233223345;4799.424069111729;5193.195054766517;5196.4803519648485;5197.688138711689;5255.684658920477;5271.3674359076385;4719.150552900443;4830.178869592108;4975.776090075955;4982.90034199314;5017.749112544431;5077.492250774967;5078.796848126033;5106.7446627669215;5140.357455318085;5258.737063146904;5106.029854327666;5111.284420181178;5123.538881500683;5125.077486052546;5131.923021154686;5082.263071854634;5084.491550844886;5102.056119617882;5102.591792656579;5155.072087024297;4069.552349241581;4106.897327566835;4164.37534369847;4164.8125834337525;4241.936370954438;3743.419769935664;3744.9063773405883;3753.9436908446396;3756.8309426075893;3787.3750831112557;4463.24124898768;4463.732176069381;4465.285554311295;4494.235979883362;4497.8200871964755;4947.727874966911;5070.569001634829;5074.695518268915;5075.5178258065425;5189.870253243699;4236.131593023423;4284.507281662649;4349.695521313541;4368.956310436855;4375.496817865923;4472.865814025585;4492.438445194351;4497.730136191839;4499;4544.7500387479;4592.747398893093;4825.734584597811;4826.469088400203;4830.420349558076;4868.123737727172;4949.82675606352;4974.32846565709;5004.774785134605;5098.980203959297;5137.460566640599;4886.53577910098;4919.655624106422;4926.359573255454;4927.827526036572;4970.254461830755;4825.059113472839;5105.463926287686;5110.540051395392;5113.872153196051;5113.900511390069;5027.522385373383;5063.088644044107;5067.062593420229;5148.330717006915;5167.896642067213;4977.502249774993;5038.823641172541;5043.470435604208;5056.241563765465;5095.745212739423;4766.761661916959;5014.774335155;5046.924296135634;5047.015831912742;5047.545720885138;4668.066386722601;4692.178868697896;4767.118083154627;4854.101991131652;4889.80440782379;5006.674566153189;5096;5097.260897169964;5098.1842905135;5129.7691603877165;4693.5306469354155;4941.703497790144;4968.900621987612;4969.527894849984;5014.899702006012 04:06:58 INFO - 2015-11-25 04:06:58,752 DEBUG : BROWSER_OUTPUT: |1;ext.html;531.2641990842683;537.9488948549889;538.2303306272031;554.1715135871872;565.9349174844895;28467.14598562044;29097.854510727444;36939.07652308694;37567;37584.62415375846;39932.201355972866;40314.59685403145;40381.99045023876;40439.797801011024;40461.190776184456;6947.09687740593;7882.251186137308;8035.718749843757;8052.235037671412;8077.596120193996;7052.259512751164;10122.74693132674;10359.171266298716;10365.378077315347;10365.792684146312;10053.447060411674;10129.696109116738;10136.89863101367;10153.746156346113;10159.13647339977;7124.109486314211;7319.707211711525;10146.898531014669;10199.133073688745;10259.948700256526;9975.700728978143;10124.69625911224;10124.746881327952;10126.392416455037;10129.13902318304;36050.63949360525;36523.81738091319;36557.63442365595;36562.26875462502;36596.451053234225;2602.9869850650816;2667.0265353146156;2832.3910359272854;3166.699163579456;3174.5238214267815;28160.577591336147;28557.714422855923;28581.71418285811;29095.56356654631;29361.559576606156;3048.527478240876;3075.7078077582596;3097.519884417919;3099.7210251077286;3127;215624;216045;216374.91812540995;218066;218135;48626.27060594094;50177.24734128991;52120.739396303536;52874.206886896725;53252.73373633107;48041.5195848044;48236.27645585249;48407.757961209965;48507.27239091346;48593;11851.762964740657;11949.64151075469;12074.75850483003;12088.274703517816;12095.516179352904;9172.587233574372;9212.907870921339;9225.308101892386;9228.123328283802;9232.630694772268;17923.37268195607;18044.27822887096;18056.819431805776;18134.183961721756;18149;7249.456290778213;7441.925580744231;7508.962455187689;7523.510971786816;7594.886076708854;819.6967122164718;868.774118729135;907.9909200908038;979.647326962293;1006.2352612014921;26472.735272647027;26682.19953401401;26837.194884153505;26919.461610768067;26939.326516836845;934.509382574154;968.138356862393;973.5278389980854;1003.2926786615419;1053.510117795229;13656.863431365759;13771.380287886868;13822;13856.515021974183;13959.86040139606;299095;305925;307025;307063;307981;47319.763401182776;47759.5224047762;47890.52109478931;47922;47928.28107578389;1198.2211562484456;1199.0227964209141;1204.8915597596258;1205.4635687119148;1209.915305928594;25713.357166070997;27033.72966270312;27247;27290.590641140003;29798.8510057457;42718;43195.13609727725;43296.350554742334;43305.783471082446;43419.56580434282;244744;248228;248768;248951;249564;32761.34477310488;32782.83608581942;34752.826235868655;35606.710770875776;39345.60654393419;31701;31722.68277317197;36750;37882.810585948;39021.60978390293;33197.83401082979;33766.15584610404;34873.30253394867;34912.65087349094;35298.470522941665;33868.83065584656;34005.48991765076;34592.65407345995;34661;34710.47934281038;31492.685073148976;32380.35239295248;33458.49812252769;34073.148171295914;34465.48301775425;28781;33507;35547.46678799872;35870.461943071394;36163.27673446569;23950.401239969142;24287;24457.177021573698;24611.753882460947;24929.501409971337 04:06:58 INFO - 2015-11-25 04:06:58,752 DEBUG : BROWSER_OUTPUT: |2;jquery.html;337.65896444590965;338.0787354459099;339.37046778226403;340.57938446019176;345.123386598041;11932.821007684892;12286.01711863051;14965.850341496582;15149.621259468518;15518.379264829407;10728.570857165703;13503.459861605525;13799.724005519909;14253;14257.429702811902;4678.368420263255;4771.475137734847;4941.530554597316;5154.871128221787;5160.587153027749;5123.513266239701;5147.6911385317;5148.897022059557;5154.175331946889;5165.380154381461;5108.974455127719;5125.487451254882;5128.102582048145;5133.435322114565;6375.266844312894;6470.061841033047;6498.220213574354;6501.0898474213645;6503.544751867371;6509.316521765218;6127.142200091991;6219.315875253718;6236.532260080512;6298.401651843067;6301.054841773725;21295.893520532452;21367.252146174964;21499;21862.45343866416;21900.89049554742;1910.5796724720678;1957.3932081054777;1958.0894883879064;1994.3518356534184;2026.7973202679761;13601;13759.38082786277;13760.862391376058;13992.160470371708;14359.210243436606;1834.2662934826044;1861.3578315481138;1877.3710806879712;1903.9428817135508;1943.1644392911044;57186.428135718525;60101.699491502266;60336.39663603352;61246.08130878085;61474;14984;15169.62075948088;15179.772303415457;15194.924025379802;15207.31567079484;18186.727199092024;18764.71852922207;19755;22325.77674223237;22395.44011399728;7186.496945213889;7355.190928997806;7425.740099096506;7509.774706758806;7576.052993375828;5840.766369345263;5936.465718085306;5998.670073146019;6024.3072046714315;6082.878342433127;7192.136943566806;7232.20445750967;7245.601491917995;7252.129744430702;7256.455765817479;2809.9859500702364;2920.72253135956;2921.6055832462343;2926.8877826425824;2980.1390664961446;707.8407358344331;728.0317178153043;738.3281214095148;819.1890028871375;842.9452085614415;14580.708385832224;14583.562493125222;14975.625609359853;15017.849821501644;15019.624509387353;755.8412733326063;818.562039434378;824.8369798583968;824.9340052795762;932.6222879733718;7623.847523049619;8473.322134229247;8694.652213911373;8831.867521987175;8922.910770892338;493992;499233;516396;520495;532367;52480.47519524832;56785.716071420204;71542;71812;71829.64085179644;928.6424726480353;954.4321128928276;961.423146112327;961.6441916490943;1074.0387353318893;14128.081674691111;14195.290235487977;14207.431702731776;14263.500777472738;14548.563543093724;27825;28566.42867142687;30173.09480715582;31870.52194217042;31955.201119972186;37599.81200093982;37926;37948.430773538974;38262.42606360962;38407.42388864225;8699.13008699125;8850.424722393023;8864.246539044254;9020.503872287087;9035.683751068682;16218.594535136715;16271;16431.917840410722;16534.09062501574;16745.581360466087;13495.662608434868;13530.526431575241;13600.727985440039;13950.162990220619;14046.087004344685;13153.06759965013;13239.801402979156;13662.590122296348;13701.931490342484;13712.17726936387;13977.860221397656;14013.5095271665;14100;14271.286435677966;14348.06737562055;8539.487630742175;8584.527850968258;8601;8632.61153248118;8920.910790892267;11930.582429614922;12600.495980161058;13639.680524595218;13841.238731869844;14095.365708542935 04:06:58 INFO - 2015-11-25 04:06:58,754 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1356.3353956561282;1373.931303434828;1398.4336343780767;1622.910739909305;1690;5522.392536820951;6535.085088087666;6765.763198288061;6793.490488213379;6804.285550017251;6898.206706228772;6979.685914133864;6996.335348141931;7009.5794252344895;7077.186123595788;1734;1760.3838656470261;1765.152726691189;2073.9170433182694;2121.501447159916;1807.6836553603132;1815.1105958080577;2087.8538502304846;2119.586680597284;2124.957500849982;2065.607534568435;2074.4917495213695;2077.345636124616;2079.1267667579577;2081.8230450411734;1971.053894130818;2006.4682859042366;2008.9497762555907;2014.869033512817;2016.0323044938439;2037.9388618341325;2046.3042565527792;2060.9896950515304;2061.051916118587;2086.248950377863;6887.6556172191695;6919.411849992756;6955.965220173917;6958.756443524503;6964.860702785966;4122.6083522065355;4163.875083747493;4183.686223533216;4186.727862688916;4189.183109293689;2753.408017276275;2793.888244470219;2849.2449500882076;2904.143277733074;2911.213972227487;874.5015341255423;877.9165979231963;879.4327658660193;896.1486587741606;921.5208091792231;9624.181944534723;9626.95186524063;9633.662821801203;9651.9034809651;9663.420194788265;3854.4603755473695;3903.375459926398;3949.54580223278;3952.782596957195;3958.247932892741;8300.916990830014;8316.417850750511;8350.540720260444;8353.498790072494;8367.874481882776;4049.919001619951;4059.1475790083823;4074.572169922175;4078.163976384834;4082.714210005271;3682.963170368316;3685.1155722626377;3687.2625474905126;3694.3165514379925;3699.315626609086;3408.2672225471147;3452.723782097426;3476.0614634048666;3478.826058697055;3486.8667683003127;959.0936564946059;974.2741657465234;1074.8172810622214;1085.4247248958065;1087.858578384805;696.019823601852;706.0080586775589;706.2090458686304;706.3960313931617;723.5513981331608;6330.778422755181;6401.9039714404325;6403.903941440882;6409.55133140685;6426.74293028283;989.3766926836047;1009.0615727373466;1009.2884516415909;1019.7297716105238;1032.6643840751785;4878.658493905393;4880.560749532559;4981;4981.427135879348;4987.700737955662;8165.959170204111;8301.2943899768;8413.70552030676;8431.620577074047;8439.493630382074;8100.554469504234;8279.006519217612;8349.958250208832;8352.081271060179;8354.832903342021;6394.552381333262;6396.2964073951825;6449.032645103272;6458.22501299847;6475.222973243147;5974.492168165754;5976.731047102804;6007.909881351696;6084.847878803065;6094.542909281733;7327.706891724271;7387.519811212254;7434.442416818868;7469.775906722807;7491.8501629966;7546.886796697944;7748.7675369739;7749.7675069748;7768.223177682186;7784.610769461618;6033.607815491979;6117.969410153099;6127.14220009208;6130;6132.264128304632;6405.967970160119;6465.903011454738;6486.902696459462;6487.026945958144;6491.05879647439;4888.877778055435;5967.671778052075;5977.46202841729;6116.755329786936;6160.3223645398075;6111.113888486234;6120.540959427972;6122.112293717475;6144.262688477412;6190.659513726789;5963.2844058713235;5983.880322393615;5996.910046349221;5999.160117583455;5999.1901093351835;5627.324721033338;5648.858778530405;5675.035244008446;5688.11834165705;5700.315962084411;5774.595778295479;5819.621724587888;5821;5823.854403639943;5834.970825145847 04:06:58 INFO - 2015-11-25 04:06:58,755 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.1583167531826;313.98273094979766;314.2928411075081;317.9443597370461;318.59379291403445;5306.355029940716;5414.566834653228;5431.864203394917;5433.755481003354;5453.318335208099;5358.785648574052;5364.409914909357;5376.247325374451;5379.246905433232;5380.784768609251;3978.8408463661417;4072.694547908904;4201.243776120297;4202.096549241913;4202.516710578292;4060.817263223162;4074.0222346636892;4137.089840235159;4140.81366338514;4220.240356735786;4150.252954468195;4151.211269858717;4161.396597493362;4174.144300418422;4174.290370636983;3916.941245881314;3995.720299579031;4031.153457773871;4167.9583204167875;4169.958300416987;3687.1888184599347;3688.188598508324;3690.1143725505685;3691.3724666806706;3694.907627309312;5139.820106296299;5154.690718556861;5154.742262886878;5160.432352441266;5175.171972484384;4825.179719447668;4831.4685384607665;4831.782569784368;4832.782524786393;4841.70949743013;5510.1459273812225;5651.095824668033;5658.122990936411;5662.943370566324;5667.4049224831215;4045.7167998240134;4047.494063242095;4048.736832105933;4048.7975601219823;4050.311447054008;5942.494887934531;5943.049112142036;5951.22634057574;5954.2259506264345;5955.404459554054;4174.352975288835;4176.331786914079;4176.519700234512;4176.665866730655;4182.435371224907;4121.8969525762095;4218.7468751874985;4242.087951090469;4245.681573881971;4259.893502662396;4803.735794531334;4813.253945638432;4814.085323788469;4814.085323788469;4818.012307476959;5675.404082571271;5681.857953551194;5685.147227915846;5689.857753556194;5690.459406356389;1476.4094362255184;1496.6408062065027;1497.468398718461;1497.5806774103269;1497.8951473396758;1022.7392015036119;1027.1628622672497;1038.7247379444452;1041.9635312764017;1057.117307048623;4973.104841128559;4974.726390048582;4987.251912213197;4992.450830408652;4997.125503036954;5834.474897259267;5863.706814659336;5869.442402971711;5873.207117039145;5875.059990401601;4964.801407943642;4972.353594032753;4978.10394129053;4981.12830254704;4988.90022199554;2925.3564215872475;3006.7293943545187;3115.750739940799;3135.576697145856;3175;5493.670379777226;5510.641808282448;5590.301212348457;5592.105263157875;5595.832125036255;6072.696365181723;6084.452399284086;6096.786612468542;6100.298465676504;6105.694715264219;5554.638948468418;5566.693831839207;5567.471090246501;5571.136473846398;5573.526250268692;5716.742746576331;5888.234529511136;5904.498117660047;5905.704714764331;5907.2911250650195;5783.768649253982;5790.10253410722;5790.594658373873;5794.101914203306;5803.187553742564;5531.668099914018;5537.640053396516;5538.892221555786;5542.974549708317;5548.944510554843;3897.8635747748694;4000.1999600079516;4041.1917616476235;4043.85846495383;4046.008727861693;5811.389804070512;5812.244408226903;5814.622049566934;5816.534677225896;5818.040023396262;5600.299962504687;5606.915896261477;5607.243022191952;5610.4670056344585;5613.46672066153;5596.440355964533;5611.551075913835;5616.634918730269;5635.746391412478;5637.633553818989;5348.491893270133;5467.562594992471;5478.616496845182;5485.807996720096;5487.64330318528;5652.604317697722;5658.434156584309;5665.235193248858;5667.518260947865;5670.716464176857;5382.4886635769535;5465.617406781487;5515.062439385234;5591.916121258103;5605.663660180402 04:06:58 INFO - 2015-11-25 04:06:58,756 DEBUG : BROWSER_OUTPUT: |5;yui.html;699.5802518488904;716.4733920568383;724.1310427487014;734.408800915263;737.4174402222245;11165.665030049102;11562.190646654737;11566.47950842211;11578.073754099672;11606.941965290183;10943.616973405933;11090.5563777449;11098.55605775768;11099.500522476488;11116.444177791098;752.4619896773805;766.6281853301144;766.643510767493;766.84279722657;767.0603510699376;612.8130920069377;617.8517155882578;761.8285885675706;777.4985134588215;778.5717855179657;808.7412028150994;809.6882700160451;817.9100298967109;818.4884447220487;819.0826274572457;630.8832865919774;637.7959053103009;808.4138999225573;810.6433169405443;811.5130921447114;473.7418107131622;473.7891638220993;474.0211463328216;588.5732843688335;598.3268822574604;11832.881671183264;11956;11971.820422693667;12006.939965300206;12016.939915300454;10629.946850265776;10760.515776789985;10869.83695244572;11253.774924501546;11435.942820285929;8701.206671124726;8837.955810220972;8861.424007439497;8975;8980.955095224548;3270.7056364927034;3300.3729291434793;3303.3723592517345;3331.566896303489;3395.9830200849083;41018.38472422916;41090.589094108975;41151.1769764606;41202.38196427056;41264.38103428481;9592.712218633453;9678.612855485702;9708.757281067888;9775.853362199572;9858.457784821903;16397.754033689504;16523.256453459624;16580.336786528405;16608.16959152062;16651.50045498637;6135.018397056449;6149.262088549313;6162.26052873658;6195.535334849814;6348.428641422294;3300.290437555937;3318.601767787881;3329.9500507492407;3351.564296641421;3369.427197376452;2767.8892844286;2790.3582176099612;2791.371941313229;2797.692253852075;2799.9160025199276;461.6399208617284;470.8893410048636;481.0331234219175;481.1387616167022;483.0869656349502;420.8548050922427;421.090444639577;429.46317103620476;429.51893878855884;432.22200039928003;7246.456515761339;7544.6227688616445;7574.394048476109;7634.198409166957;7659.080910290801;433.59025720694274;468.27183729300583;496.9602431805447;513.2762804445714;524.6825670469311;3293.4730443128983;3771.792551409644;3783.3379158647126;3822.9617703822605;3917.941230881539;50254.49745502571;51170.48829511657;51257.48742512602;51304.74347628238;51308.486915131114;44462.77768611201;45098.32352514715;45174.096518069455;45809;46364.76817615958;41738.79130604388;42382.36426453606;43589.56410435855;43691.78154109273;43874;6980;7143.892841607276;8072.4349295548745;8180.304674102768;8393.37049721261;32911;33346.33307333888;33960.83019584886;34209.82895085509;34464.138396540286;38809.2238155241;41040.58959410368;41703.374449382674;41928.161436771705;42003.36994945017;9488.33581649278;9555.952220239133;9716;9835.85246221293;9892.911779704371;10688.25182237236;10722.839157412489;10734.194935380034;10762.40806755636;10882.183836212474;9978.750531236778;10300;10409.68770936873;10446.112080473245;10764.623238186627;10244.64143754965;10281.948590257001;10301.536430860479;10318.587256509656;10321.122704570196;10397.220208484243;10523.789524209626;10567.94716026415;10607.363558186533;10754.51604677807;7978.481398709066;8131.959340203498;8146.83706325882;8469.957650211709;8479;8192.426530143071;8524.262630803476;8584.313254939714;8749.343799214957;8762.506373857159 04:06:58 INFO - 2015-11-25 04:06:58,756 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:06:58 INFO - 2015-11-25 04:06:58,756 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:06:58 INFO - 2015-11-25 04:06:58,756 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,911 04:06:58 INFO - 2015-11-25 04:06:58,756 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: __startTimestamp1448453218744__endTimestamp 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: Number of tests: 6 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4702.29 Median:4826.47 stddev:498.19 (10.3%) stddev-sans-first:473.36 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: Values: 2663.9 2728.4 2738.8 2752.1 2753.4 4614.0 4701.2 4735.5 4755.7 4782.0 4679.0 4710.5 4720.6 4839.2 4854.7 4278.8 4343.5 4354.1 4373.7 4438.6 4401.4 4445.1 4456.8 4503.2 4508.8 4232.4 4340.7 4487.6 4521.1 4525.9 4306.9 4330.9 4338.0 4341.9 4344.3 4327.5 4331.8 4331.9 4338.3 4340.0 4587.9 4677.3 4698.8 4700.9 4718.5 5082.3 5126.7 5130.1 5142.7 5183.7 4850.9 4971.1 5151.1 5164.9 5168.5 4621.5 4685.7 4754.3 4759.7 4799.4 5193.2 5196.5 5197.7 5255.7 5271.4 4719.2 4830.2 4975.8 4982.9 5017.7 5077.5 5078.8 5106.7 5140.4 5258.7 5106.0 5111.3 5123.5 5125.1 5131.9 5082.3 5084.5 5102.1 5102.6 5155.1 4069.6 4106.9 4164.4 4164.8 4241.9 3743.4 3744.9 3753.9 3756.8 3787.4 4463.2 4463.7 4465.3 4494.2 4497.8 4947.7 5070.6 5074.7 5075.5 5189.9 4236.1 4284.5 4349.7 4369.0 4375.5 4472.9 4492.4 4497.7 4499.0 4544.8 4592.7 4825.7 4826.5 4830.4 4868.1 4949.8 4974.3 5004.8 5099.0 5137.5 4886.5 4919.7 4926.4 4927.8 4970.3 4825.1 5105.5 5110.5 5113.9 5113.9 5027.5 5063.1 5067.1 5148.3 5167.9 4977.5 5038.8 5043.5 5056.2 5095.7 4766.8 5014.8 5046.9 5047.0 5047.5 4668.1 4692.2 4767.1 4854.1 4889.8 5006.7 5096.0 5097.3 5098.2 5129.8 4693.5 4941.7 4968.9 4969.5 5014.9 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41732.99 Median:32570.85 stddev:67619.50 (207.6%) stddev-sans-first:67738.43 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: Values: 531.3 537.9 538.2 554.2 565.9 28467.1 29097.9 36939.1 37567.0 37584.6 39932.2 40314.6 40382.0 40439.8 40461.2 6947.1 7882.3 8035.7 8052.2 8077.6 7052.3 10122.7 10359.2 10365.4 10365.8 10053.4 10129.7 10136.9 10153.7 10159.1 7124.1 7319.7 10146.9 10199.1 10259.9 9975.7 10124.7 10124.7 10126.4 10129.1 36050.6 36523.8 36557.6 36562.3 36596.5 2603.0 2667.0 2832.4 3166.7 3174.5 28160.6 28557.7 28581.7 29095.6 29361.6 3048.5 3075.7 3097.5 3099.7 3127.0 215624.0 216045.0 216374.9 218066.0 218135.0 48626.3 50177.2 52120.7 52874.2 53252.7 48041.5 48236.3 48407.8 48507.3 48593.0 11851.8 11949.6 12074.8 12088.3 12095.5 9172.6 9212.9 9225.3 9228.1 9232.6 17923.4 18044.3 18056.8 18134.2 18149.0 7249.5 7441.9 7509.0 7523.5 7594.9 819.7 868.8 908.0 979.6 1006.2 26472.7 26682.2 26837.2 26919.5 26939.3 934.5 968.1 973.5 1003.3 1053.5 13656.9 13771.4 13822.0 13856.5 13959.9 299095.0 305925.0 307025.0 307063.0 307981.0 47319.8 47759.5 47890.5 47922.0 47928.3 1198.2 1199.0 1204.9 1205.5 1209.9 25713.4 27033.7 27247.0 27290.6 29798.9 42718.0 43195.1 43296.4 43305.8 43419.6 244744.0 248228.0 248768.0 248951.0 249564.0 32761.3 32782.8 34752.8 35606.7 39345.6 31701.0 31722.7 36750.0 37882.8 39021.6 33197.8 33766.2 34873.3 34912.7 35298.5 33868.8 34005.5 34592.7 34661.0 34710.5 31492.7 32380.4 33458.5 34073.1 34465.5 28781.0 33507.0 35547.5 35870.5 36163.3 23950.4 24287.0 24457.2 24611.8 24929.5 04:06:58 INFO - 2015-11-25 04:06:58,757 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,758 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27456.63 Median:18972.47 stddev:83503.59 (440.1%) stddev-sans-first:83713.01 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: Values: 337.7 338.1 339.4 340.6 345.1 11932.8 12286.0 14965.9 15149.6 15518.4 10728.6 13503.5 13799.7 14253.0 14257.4 4678.4 4771.5 4941.5 5154.9 5160.6 5123.5 5147.7 5148.9 5154.2 5165.4 5109.0 5125.5 5128.1 5133.4 6375.3 6470.1 6498.2 6501.1 6503.5 6509.3 6127.1 6219.3 6236.5 6298.4 6301.1 21295.9 21367.3 21499.0 21862.5 21900.9 1910.6 1957.4 1958.1 1994.4 2026.8 13601.0 13759.4 13760.9 13992.2 14359.2 1834.3 1861.4 1877.4 1903.9 1943.2 57186.4 60101.7 60336.4 61246.1 61474.0 14984.0 15169.6 15179.8 15194.9 15207.3 18186.7 18764.7 19755.0 22325.8 22395.4 7186.5 7355.2 7425.7 7509.8 7576.1 5840.8 5936.5 5998.7 6024.3 6082.9 7192.1 7232.2 7245.6 7252.1 7256.5 2810.0 2920.7 2921.6 2926.9 2980.1 707.8 728.0 738.3 819.2 842.9 14580.7 14583.6 14975.6 15017.8 15019.6 755.8 818.6 824.8 824.9 932.6 7623.8 8473.3 8694.7 8831.9 8922.9 493992.0 499233.0 516396.0 520495.0 532367.0 52480.5 56785.7 71542.0 71812.0 71829.6 928.6 954.4 961.4 961.6 1074.0 14128.1 14195.3 14207.4 14263.5 14548.6 27825.0 28566.4 30173.1 31870.5 31955.2 37599.8 37926.0 37948.4 38262.4 38407.4 8699.1 8850.4 8864.2 9020.5 9035.7 16218.6 16271.0 16431.9 16534.1 16745.6 13495.7 13530.5 13600.7 13950.2 14046.1 13153.1 13239.8 13662.6 13701.9 13712.2 13977.9 14013.5 14100.0 14271.3 14348.1 8539.5 8584.5 8601.0 8632.6 8920.9 11930.6 12600.5 13639.7 13841.2 14095.4 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4813.48 Median:5998.04 stddev:2508.98 (41.8%) stddev-sans-first:2502.56 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: Values: 1356.3 1373.9 1398.4 1622.9 1690.0 5522.4 6535.1 6765.8 6793.5 6804.3 6898.2 6979.7 6996.3 7009.6 7077.2 1734.0 1760.4 1765.2 2073.9 2121.5 1807.7 1815.1 2087.9 2119.6 2125.0 2065.6 2074.5 2077.3 2079.1 2081.8 1971.1 2006.5 2008.9 2014.9 2016.0 2037.9 2046.3 2061.0 2061.1 2086.2 6887.7 6919.4 6956.0 6958.8 6964.9 4122.6 4163.9 4183.7 4186.7 4189.2 2753.4 2793.9 2849.2 2904.1 2911.2 874.5 877.9 879.4 896.1 921.5 9624.2 9627.0 9633.7 9651.9 9663.4 3854.5 3903.4 3949.5 3952.8 3958.2 8300.9 8316.4 8350.5 8353.5 8367.9 4049.9 4059.1 4074.6 4078.2 4082.7 3683.0 3685.1 3687.3 3694.3 3699.3 3408.3 3452.7 3476.1 3478.8 3486.9 959.1 974.3 1074.8 1085.4 1087.9 696.0 706.0 706.2 706.4 723.6 6330.8 6401.9 6403.9 6409.6 6426.7 989.4 1009.1 1009.3 1019.7 1032.7 4878.7 4880.6 4981.0 4981.4 4987.7 8166.0 8301.3 8413.7 8431.6 8439.5 8100.6 8279.0 8350.0 8352.1 8354.8 6394.6 6396.3 6449.0 6458.2 6475.2 5974.5 5976.7 6007.9 6084.8 6094.5 7327.7 7387.5 7434.4 7469.8 7491.9 7546.9 7748.8 7749.8 7768.2 7784.6 6033.6 6118.0 6127.1 6130.0 6132.3 6406.0 6465.9 6486.9 6487.0 6491.1 4888.9 5967.7 5977.5 6116.8 6160.3 6111.1 6120.5 6122.1 6144.3 6190.7 5963.3 5983.9 5996.9 5999.2 5999.2 5627.3 5648.9 5675.0 5688.1 5700.3 5774.6 5819.6 5821.0 5823.9 5835.0 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4702.42 Median:5327.42 stddev:1370.73 (25.7%) stddev-sans-first:1334.36 04:06:58 INFO - 2015-11-25 04:06:58,759 DEBUG : BROWSER_OUTPUT: Values: 311.2 314.0 314.3 317.9 318.6 5306.4 5414.6 5431.9 5433.8 5453.3 5358.8 5364.4 5376.2 5379.2 5380.8 3978.8 4072.7 4201.2 4202.1 4202.5 4060.8 4074.0 4137.1 4140.8 4220.2 4150.3 4151.2 4161.4 4174.1 4174.3 3916.9 3995.7 4031.2 4168.0 4170.0 3687.2 3688.2 3690.1 3691.4 3694.9 5139.8 5154.7 5154.7 5160.4 5175.2 4825.2 4831.5 4831.8 4832.8 4841.7 5510.1 5651.1 5658.1 5662.9 5667.4 4045.7 4047.5 4048.7 4048.8 4050.3 5942.5 5943.0 5951.2 5954.2 5955.4 4174.4 4176.3 4176.5 4176.7 4182.4 4121.9 4218.7 4242.1 4245.7 4259.9 4803.7 4813.3 4814.1 4814.1 4818.0 5675.4 5681.9 5685.1 5689.9 5690.5 1476.4 1496.6 1497.5 1497.6 1497.9 1022.7 1027.2 1038.7 1042.0 1057.1 4973.1 4974.7 4987.3 4992.5 4997.1 5834.5 5863.7 5869.4 5873.2 5875.1 4964.8 4972.4 4978.1 4981.1 4988.9 2925.4 3006.7 3115.8 3135.6 3175.0 5493.7 5510.6 5590.3 5592.1 5595.8 6072.7 6084.5 6096.8 6100.3 6105.7 5554.6 5566.7 5567.5 5571.1 5573.5 5716.7 5888.2 5904.5 5905.7 5907.3 5783.8 5790.1 5790.6 5794.1 5803.2 5531.7 5537.6 5538.9 5543.0 5548.9 3897.9 4000.2 4041.2 4043.9 4046.0 5811.4 5812.2 5814.6 5816.5 5818.0 5600.3 5606.9 5607.2 5610.5 5613.5 5596.4 5611.6 5616.6 5635.7 5637.6 5348.5 5467.6 5478.6 5485.8 5487.6 5652.6 5658.4 5665.2 5667.5 5670.7 5382.5 5465.6 5515.1 5591.9 5605.7 04:06:58 INFO - 2015-11-25 04:06:58,760 DEBUG : BROWSER_OUTPUT: 04:06:58 INFO - 2015-11-25 04:06:58,761 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12360.74 Median:44780.55 stddev:14368.94 (32.1%) stddev-sans-first:14382.56 04:06:58 INFO - 2015-11-25 04:06:58,761 DEBUG : BROWSER_OUTPUT: Values: 699.6 716.5 724.1 734.4 737.4 11165.7 11562.2 11566.5 11578.1 11606.9 10943.6 11090.6 11098.6 11099.5 11116.4 752.5 766.6 766.6 766.8 767.1 612.8 617.9 761.8 777.5 778.6 808.7 809.7 817.9 818.5 819.1 630.9 637.8 808.4 810.6 811.5 473.7 473.8 474.0 588.6 598.3 11832.9 11956.0 11971.8 12006.9 12016.9 10629.9 10760.5 10869.8 11253.8 11435.9 8701.2 8838.0 8861.4 8975.0 8981.0 3270.7 3300.4 3303.4 3331.6 3396.0 41018.4 41090.6 41151.2 41202.4 41264.4 9592.7 9678.6 9708.8 9775.9 9858.5 16397.8 16523.3 16580.3 16608.2 16651.5 6135.0 6149.3 6162.3 6195.5 6348.4 3300.3 3318.6 3330.0 3351.6 3369.4 2767.9 2790.4 2791.4 2797.7 2799.9 461.6 470.9 481.0 481.1 483.1 420.9 421.1 429.5 429.5 432.2 7246.5 7544.6 7574.4 7634.2 7659.1 433.6 468.3 497.0 513.3 524.7 3293.5 3771.8 3783.3 3823.0 3917.9 50254.5 51170.5 51257.5 51304.7 51308.5 44462.8 45098.3 45174.1 45809.0 46364.8 41738.8 42382.4 43589.6 43691.8 43874.0 6980.0 7143.9 8072.4 8180.3 8393.4 32911.0 33346.3 33960.8 34209.8 34464.1 38809.2 41040.6 41703.4 41928.2 42003.4 9488.3 9556.0 9716.0 9835.9 9892.9 10688.3 10722.8 10734.2 10762.4 10882.2 9978.8 10300.0 10409.7 10446.1 10764.6 10244.6 10281.9 10301.5 10318.6 10321.1 10397.2 10523.8 10567.9 10607.4 10754.5 7978.5 8132.0 8146.8 8470.0 8479.0 8192.4 8524.3 8584.3 8749.3 8762.5 04:06:58 INFO - 2015-11-25 04:06:58,761 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:06:58 INFO - 2015-11-25 04:06:58,761 DEBUG : BROWSER_OUTPUT: 04:06:59 INFO - 2015-11-25 04:06:59,497 INFO : Browser exited with error code: 0 04:06:59 INFO - 2015-11-25 04:06:59,516 INFO : Completed test dromaeo_css (00:18:37) 04:06:59 INFO - 2015-11-25 04:06:59,516 INFO : Starting test kraken 04:06:59 INFO - 2015-11-25 04:06:59,516 DEBUG : operating with platform_type : linux_ 04:06:59 INFO - 2015-11-25 04:06:59,516 INFO : Initialising browser for kraken test... 04:06:59 INFO - 2015-11-25 04:06:59,522 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCaa2Dx/profile http://localhost:45362/getInfo.html 04:07:03 INFO - 2015-11-25 04:07:03,604 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:07:03 INFO - 2015-11-25 04:07:03,604 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:07:03 INFO - 2015-11-25 04:07:03,604 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:07:03 INFO - 2015-11-25 04:07:03,604 DEBUG : BROWSER_OUTPUT: __metrics 04:07:03 INFO - 2015-11-25 04:07:03,725 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:04 INFO - 2015-11-25 04:07:04,992 INFO : Browser initialized. 04:07:04 INFO - 2015-11-25 04:07:04,992 INFO : Running cycle 1/1 for kraken test... 04:07:04 INFO - 2015-11-25 04:07:04,993 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpCaa2Dx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:07:16 INFO - 2015-11-25 04:07:16,826 DEBUG : BROWSER_OUTPUT: RSS: Main: 140890112 04:07:16 INFO - 2015-11-25 04:07:16,826 DEBUG : BROWSER_OUTPUT: 04:07:19 INFO - 2015-11-25 04:07:19,405 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-beat-detection) 04:07:19 INFO - 2015-11-25 04:07:19,987 DEBUG : BROWSER_OUTPUT: RSS: Main: 178794496 04:07:19 INFO - 2015-11-25 04:07:19,987 DEBUG : BROWSER_OUTPUT: 04:07:22 INFO - 2015-11-25 04:07:22,723 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-dft) 04:07:23 INFO - 2015-11-25 04:07:23,296 DEBUG : BROWSER_OUTPUT: RSS: Main: 167337984 04:07:23 INFO - 2015-11-25 04:07:23,296 DEBUG : BROWSER_OUTPUT: 04:07:26 INFO - 2015-11-25 04:07:26,321 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-fft) 04:07:26 INFO - 2015-11-25 04:07:26,887 DEBUG : BROWSER_OUTPUT: RSS: Main: 151810048 04:07:26 INFO - 2015-11-25 04:07:26,887 DEBUG : BROWSER_OUTPUT: 04:07:28 INFO - 2015-11-25 04:07:28,920 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:45362/tests/kraken/driver.html?testName=audio-oscillator) 04:07:29 INFO - 2015-11-25 04:07:29,486 DEBUG : BROWSER_OUTPUT: RSS: Main: 154255360 04:07:29 INFO - 2015-11-25 04:07:29,487 DEBUG : BROWSER_OUTPUT: 04:07:31 INFO - 2015-11-25 04:07:31,760 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:07:32 INFO - 2015-11-25 04:07:32,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 154402816 04:07:32 INFO - 2015-11-25 04:07:32,326 DEBUG : BROWSER_OUTPUT: 04:07:35 INFO - 2015-11-25 04:07:35,284 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-darkroom) 04:07:35 INFO - 2015-11-25 04:07:35,870 DEBUG : BROWSER_OUTPUT: RSS: Main: 155123712 04:07:35 INFO - 2015-11-25 04:07:35,870 DEBUG : BROWSER_OUTPUT: 04:07:39 INFO - 2015-11-25 04:07:39,319 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:45362/tests/kraken/driver.html?testName=imaging-desaturate) 04:07:39 INFO - 2015-11-25 04:07:39,904 DEBUG : BROWSER_OUTPUT: RSS: Main: 156221440 04:07:39 INFO - 2015-11-25 04:07:39,904 DEBUG : BROWSER_OUTPUT: 04:07:42 INFO - 2015-11-25 04:07:42,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:45362/tests/kraken/driver.html?testName=json-parse-financial) 04:07:43 INFO - 2015-11-25 04:07:43,326 DEBUG : BROWSER_OUTPUT: RSS: Main: 156692480 04:07:43 INFO - 2015-11-25 04:07:43,326 DEBUG : BROWSER_OUTPUT: 04:07:45 INFO - 2015-11-25 04:07:45,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:45362/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:07:45 INFO - 2015-11-25 04:07:45,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 167501824 04:07:45 INFO - 2015-11-25 04:07:45,664 DEBUG : BROWSER_OUTPUT: 04:07:47 INFO - 2015-11-25 04:07:47,533 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:07:48 INFO - 2015-11-25 04:07:48,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 166006784 04:07:48 INFO - 2015-11-25 04:07:48,126 DEBUG : BROWSER_OUTPUT: 04:07:50 INFO - 2015-11-25 04:07:50,229 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:07:50 INFO - 2015-11-25 04:07:50,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 175505408 04:07:50 INFO - 2015-11-25 04:07:50,803 DEBUG : BROWSER_OUTPUT: 04:07:53 INFO - 2015-11-25 04:07:53,297 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:07:53 INFO - 2015-11-25 04:07:53,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 181903360 04:07:53 INFO - 2015-11-25 04:07:53,883 DEBUG : BROWSER_OUTPUT: 04:07:56 INFO - 2015-11-25 04:07:56,459 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:07:57 INFO - 2015-11-25 04:07:57,032 DEBUG : BROWSER_OUTPUT: RSS: Main: 179613696 04:07:57 INFO - 2015-11-25 04:07:57,032 DEBUG : BROWSER_OUTPUT: 04:07:58 INFO - 2015-11-25 04:07:58,782 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:45362/tests/kraken/driver.html?testName=ai-astar) 04:07:59 INFO - 2015-11-25 04:07:59,028 DEBUG : BROWSER_OUTPUT: RSS: Main: 239427584 04:07:59 INFO - 2015-11-25 04:07:59,028 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,031 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:07:59 INFO - 2015-11-25 04:07:59,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:07:59 INFO - 2015-11-25 04:07:59,031 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;113;106;112;113;113;101;113;111;104 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;129;153;170;134;158;161;133;180;133 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;161;160;161;162;163;162 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;89;88;75;73;78;122;96;76 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;126;93;96;94;136;94;94;144 04:07:59 INFO - 2015-11-25 04:07:59,032 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;109;109;110;110;109;110;110;109;110 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;148;146;146;146;147;146;146;146;147 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;96;95;95;96;96;95;95 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;71;70;72;71;71;71;80;70;68 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;68;68;68;68;68;68;68;68 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;83;85;83;83;86;87;83;85;83 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;120;121;120;118;128;119;127;115;128 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;138;143;147;146;144;154;152;143;147;135 04:07:59 INFO - 2015-11-25 04:07:59,033 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;68;74;70;68;71;67;70;69 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: __start_cc_report 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,972 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: __end_cc_report 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: __startTimestamp1448453279029__endTimestamp 04:07:59 INFO - 2015-11-25 04:07:59,034 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: Number of tests: 14 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:109.70 Median:112.50 stddev:4.40 (3.9%) stddev-sans-first:4.64 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: Values: 111.0 113.0 106.0 112.0 113.0 113.0 101.0 113.0 111.0 104.0 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.70 Median:157.00 stddev:17.64 (11.2%) stddev-sans-first:18.60 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: Values: 156.0 129.0 153.0 170.0 134.0 158.0 161.0 133.0 180.0 133.0 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:161.50 stddev:0.84 (0.5%) stddev-sans-first:0.88 04:07:59 INFO - 2015-11-25 04:07:59,042 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 161.0 160.0 161.0 162.0 163.0 162.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:84.10 Median:77.00 stddev:15.70 (20.4%) stddev-sans-first:16.03 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 89.0 88.0 75.0 73.0 78.0 122.0 96.0 76.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:106.60 Median:94.00 stddev:20.29 (21.6%) stddev-sans-first:21.09 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 126.0 93.0 96.0 94.0 136.0 94.0 94.0 144.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: Values: 110.0 109.0 109.0 110.0 110.0 109.0 110.0 110.0 109.0 110.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:146.50 stddev:0.71 (0.5%) stddev-sans-first:0.73 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: Values: 147.0 148.0 146.0 146.0 146.0 147.0 146.0 146.0 146.0 147.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 96.0 95.0 95.0 96.0 96.0 95.0 95.0 04:07:59 INFO - 2015-11-25 04:07:59,043 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.40 Median:71.00 stddev:3.20 (4.5%) stddev-sans-first:3.36 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: Values: 70.0 71.0 70.0 72.0 71.0 71.0 71.0 80.0 70.0 68.0 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.10 Median:68.00 stddev:0.32 (0.5%) stddev-sans-first:0.33 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 68.0 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:84.20 Median:84.50 stddev:1.48 (1.7%) stddev-sans-first:1.56 04:07:59 INFO - 2015-11-25 04:07:59,044 DEBUG : BROWSER_OUTPUT: Values: 84.0 83.0 85.0 83.0 83.0 86.0 87.0 83.0 85.0 83.0 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:121.70 Median:121.00 stddev:4.47 (3.7%) stddev-sans-first:4.74 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: Values: 121.0 120.0 121.0 120.0 118.0 128.0 119.0 127.0 115.0 128.0 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.90 Median:146.50 stddev:5.74 (3.9%) stddev-sans-first:5.52 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: Values: 138.0 143.0 147.0 146.0 144.0 154.0 152.0 143.0 147.0 135.0 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.10 Median:69.50 stddev:2.23 (3.2%) stddev-sans-first:2.24 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 68.0 74.0 70.0 68.0 71.0 67.0 70.0 69.0 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:07:59 INFO - 2015-11-25 04:07:59,045 DEBUG : BROWSER_OUTPUT: 04:07:59 INFO - 2015-11-25 04:07:59,977 INFO : Browser exited with error code: 0 04:08:00 INFO - 2015-11-25 04:08:00,032 INFO : Completed test kraken (00:01:00) 04:08:00 INFO - 2015-11-25 04:08:00,032 INFO : Starting test v8_7 04:08:00 INFO - 2015-11-25 04:08:00,032 DEBUG : operating with platform_type : linux_ 04:08:00 INFO - 2015-11-25 04:08:00,032 INFO : Initialising browser for v8_7 test... 04:08:00 INFO - 2015-11-25 04:08:00,038 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnxCel/profile http://localhost:45362/getInfo.html 04:08:04 INFO - 2015-11-25 04:08:04,100 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 04:08:04 INFO - 2015-11-25 04:08:04,100 DEBUG : BROWSER_OUTPUT: colorDepth:24 04:08:04 INFO - 2015-11-25 04:08:04,100 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 04:08:04 INFO - 2015-11-25 04:08:04,100 DEBUG : BROWSER_OUTPUT: __metrics 04:08:04 INFO - 2015-11-25 04:08:04,229 DEBUG : BROWSER_OUTPUT: JavaScript error: resource://app/modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:08:05 INFO - 2015-11-25 04:08:05,508 INFO : Browser initialized. 04:08:05 INFO - 2015-11-25 04:08:05,508 INFO : Running cycle 1/1 for v8_7 test... 04:08:05 INFO - 2015-11-25 04:08:05,508 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwnxCel/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 04:08:17 INFO - 2015-11-25 04:08:17,303 DEBUG : BROWSER_OUTPUT: RSS: Main: 140775424 04:08:17 INFO - 2015-11-25 04:08:17,303 DEBUG : BROWSER_OUTPUT: 04:08:38 INFO - 2015-11-25 04:08:38,777 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:45362/tests/v8_7/run.html (next: http://localhost:45362/tests/v8_7/run.html) 04:08:39 INFO - 2015-11-25 04:08:39,027 DEBUG : BROWSER_OUTPUT: RSS: Main: 448929792 04:08:39 INFO - 2015-11-25 04:08:39,027 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,027 DEBUG : BROWSER_OUTPUT: __start_tp_report 04:08:39 INFO - 2015-11-25 04:08:39,027 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 04:08:39 INFO - 2015-11-25 04:08:39,028 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 04:08:39 INFO - 2015-11-25 04:08:39,028 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 04:08:39 INFO - 2015-11-25 04:08:39,028 DEBUG : BROWSER_OUTPUT: |0;Richards;164.52780519907864 04:08:39 INFO - 2015-11-25 04:08:39,028 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.23375624759709 04:08:39 INFO - 2015-11-25 04:08:39,028 DEBUG : BROWSER_OUTPUT: |2;Encrypt;277.85495971103086 04:08:39 INFO - 2015-11-25 04:08:39,029 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5180.412371134021 04:08:39 INFO - 2015-11-25 04:08:39,029 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 04:08:39 INFO - 2015-11-25 04:08:39,029 DEBUG : BROWSER_OUTPUT: |5;Earley;800 04:08:39 INFO - 2015-11-25 04:08:39,029 DEBUG : BROWSER_OUTPUT: |6;Boyer;12243.90243902439 04:08:39 INFO - 2015-11-25 04:08:39,030 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 04:08:39 INFO - 2015-11-25 04:08:39,030 DEBUG : BROWSER_OUTPUT: |8;Splay;593.4718100890208 04:08:39 INFO - 2015-11-25 04:08:39,030 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4830.917874396136 04:08:39 INFO - 2015-11-25 04:08:39,030 DEBUG : BROWSER_OUTPUT: __end_tp_report 04:08:39 INFO - 2015-11-25 04:08:39,031 DEBUG : BROWSER_OUTPUT: __startTimestamp1448453319026__endTimestamp 04:08:39 INFO - 2015-11-25 04:08:39,031 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,031 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 04:08:39 INFO - 2015-11-25 04:08:39,031 DEBUG : BROWSER_OUTPUT: Number of tests: 10 04:08:39 INFO - 2015-11-25 04:08:39,032 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,032 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.53 Median:164.53 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,033 DEBUG : BROWSER_OUTPUT: Values: 164.5 04:08:39 INFO - 2015-11-25 04:08:39,034 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,034 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.23 Median:192.23 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,034 DEBUG : BROWSER_OUTPUT: Values: 192.2 04:08:39 INFO - 2015-11-25 04:08:39,034 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,034 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:277.85 Median:277.85 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,035 DEBUG : BROWSER_OUTPUT: Values: 277.9 04:08:39 INFO - 2015-11-25 04:08:39,035 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,035 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5180.41 Median:5180.41 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,035 DEBUG : BROWSER_OUTPUT: Values: 5180.4 04:08:39 INFO - 2015-11-25 04:08:39,035 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,036 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,036 DEBUG : BROWSER_OUTPUT: Values: 1972.4 04:08:39 INFO - 2015-11-25 04:08:39,036 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,036 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:800.00 Median:800.00 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: Values: 800.0 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12243.90 Median:12243.90 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: Values: 12243.9 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,037 DEBUG : BROWSER_OUTPUT: Values: 26025.6 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:593.47 Median:593.47 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: Values: 593.5 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4830.92 Median:4830.92 stddev:0.00 (0.0%) 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: Values: 4830.9 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 04:08:39 INFO - 2015-11-25 04:08:39,038 DEBUG : BROWSER_OUTPUT: 04:08:39 INFO - 2015-11-25 04:08:39,870 INFO : Browser exited with error code: 0 04:08:39 INFO - 2015-11-25 04:08:39,888 INFO : Completed test v8_7 (00:00:39) 04:08:39 INFO - 2015-11-25 04:08:39,979 INFO : Completed test suite (00:20:17) 04:08:39 INFO - 2015-11-25 04:08:39,980 DEBUG : Working with test: dromaeo_css 04:08:39 INFO - 2015-11-25 04:08:39,980 DEBUG : Generating results file: dromaeo_css 04:08:39 INFO - 2015-11-25 04:08:39,981 DEBUG : Working with test: kraken 04:08:39 INFO - 2015-11-25 04:08:39,981 DEBUG : Generating results file: kraken 04:08:39 INFO - 2015-11-25 04:08:39,981 INFO : javascript benchmark 04:08:39 INFO - 2015-11-25 04:08:39,981 DEBUG : Working with test: v8_7 04:08:39 INFO - 2015-11-25 04:08:39,981 DEBUG : Generating results file: v8_7 04:08:39 INFO - 2015-11-25 04:08:39,982 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:40 INFO - 2015-11-25 04:08:40,034 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 04:08:40 INFO - 2015-11-25 04:08:40,034 DEBUG : process_Request line: dromaeo_css 6357.44 graph.html#tests=[[72,203,35]] 04:08:40 INFO - 2015-11-25 04:08:40,034 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:40 INFO - 2015-11-25 04:08:40,065 DEBUG : process_Request line: kraken 1523.40 graph.html#tests=[[232,203,35]] 04:08:40 INFO - 2015-11-25 04:08:40,065 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 04:08:40 INFO - 2015-11-25 04:08:40,093 DEBUG : process_Request line: v8_7 19846.67 graph.html#tests=[[230,203,35]] 04:08:40 INFO - 2015-11-25 04:08:40,098 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.8934442622294, 2728.372474330904, 2738.83566985981, 2752.133078080406, 2753.352962053917, 4613.9538604613945, 4701.200795864703, 4735.502772208912, 4755.738434386111, 4782.043591281745, 4678.976605116978, 4710.481846996828, 4720.59874910633, 4839.15314819906, 4854.708717476954, 4278.807453664593, 4343.522212556616, 4354.063876266602, 4373.671974601902, 4438.600525952664, 4401.405810215628, 4445.066536027438, 4456.777161141946, 4503.234450143484, 4508.77456127194, 4232.449781528412, 4340.674449416275, 4487.640988720895, 4521.118381915528, 4525.909481810362, 4306.935395969063, 4330.870073897788, 4338.045629961403, 4341.934870976938, 4344.348347747831, 4327.502337231227, 4331.7617531035785, 4331.891702707426, 4338.284183109815, 4339.978300108511, 4587.9082418351445, 4677.321788340671, 4698.7650617469335, 4700.929486057712, 4718.4809670936165, 5082.263071854597, 5126.6923984561045, 5130.050940576006, 5142.717150556718, 5183.714895680736, 4850.854474365775, 4971.080350135237, 5151.072806894795, 5164.92252616211, 5168.508991645787, 4621.514740952185, 4685.718856868633, 4754.334393184957, 4759.6668233223345, 4799.424069111729, 5193.195054766517, 5196.4803519648485, 5197.688138711689, 5255.684658920477, 5271.3674359076385, 4719.150552900443, 4830.178869592108, 4975.776090075955, 4982.90034199314, 5017.749112544431, 5077.492250774967, 5078.796848126033, 5106.7446627669215, 5140.357455318085, 5258.737063146904, 5106.029854327666, 5111.284420181178, 5123.538881500683, 5125.077486052546, 5131.923021154686, 5082.263071854634, 5084.491550844886, 5102.056119617882, 5102.591792656579, 5155.072087024297, 4069.552349241581, 4106.897327566835, 4164.37534369847, 4164.8125834337525, 4241.936370954438, 3743.419769935664, 3744.9063773405883, 3753.9436908446396, 3756.8309426075893, 3787.3750831112557, 4463.24124898768, 4463.732176069381, 4465.285554311295, 4494.235979883362, 4497.8200871964755, 4947.727874966911, 5070.569001634829, 5074.695518268915, 5075.5178258065425, 5189.870253243699, 4236.131593023423, 4284.507281662649, 4349.695521313541, 4368.956310436855, 4375.496817865923, 4472.865814025585, 4492.438445194351, 4497.730136191839, 4499.0, 4544.7500387479, 4592.747398893093, 4825.734584597811, 4826.469088400203, 4830.420349558076, 4868.123737727172, 4949.82675606352, 4974.32846565709, 5004.774785134605, 5098.980203959297, 5137.460566640599, 4886.53577910098, 4919.655624106422, 4926.359573255454, 4927.827526036572, 4970.254461830755, 4825.059113472839, 5105.463926287686, 5110.540051395392, 5113.872153196051, 5113.900511390069, 5027.522385373383, 5063.088644044107, 5067.062593420229, 5148.330717006915, 5167.896642067213, 4977.502249774993, 5038.823641172541, 5043.470435604208, 5056.241563765465, 5095.745212739423, 4766.761661916959, 5014.774335155, 5046.924296135634, 5047.015831912742, 5047.545720885138, 4668.066386722601, 4692.178868697896, 4767.118083154627, 4854.101991131652, 4889.80440782379, 5006.674566153189, 5096.0, 5097.260897169964, 5098.1842905135, 5129.7691603877165, 4693.5306469354155, 4941.703497790144, 4968.900621987612, 4969.527894849984, 5014.899702006012], "unit": "ms", "name": "dojo.html", "value": 4671.147185547299}, {"lowerIsBetter": false, "replicates": [531.2641990842683, 537.9488948549889, 538.2303306272031, 554.1715135871872, 565.9349174844895, 28467.14598562044, 29097.854510727444, 36939.07652308694, 37567.0, 37584.62415375846, 39932.201355972866, 40314.59685403145, 40381.99045023876, 40439.797801011024, 40461.190776184456, 6947.09687740593, 7882.251186137308, 8035.718749843757, 8052.235037671412, 8077.596120193996, 7052.259512751164, 10122.74693132674, 10359.171266298716, 10365.378077315347, 10365.792684146312, 10053.447060411674, 10129.696109116738, 10136.89863101367, 10153.746156346113, 10159.13647339977, 7124.109486314211, 7319.707211711525, 10146.898531014669, 10199.133073688745, 10259.948700256526, 9975.700728978143, 10124.69625911224, 10124.746881327952, 10126.392416455037, 10129.13902318304, 36050.63949360525, 36523.81738091319, 36557.63442365595, 36562.26875462502, 36596.451053234225, 2602.9869850650816, 2667.0265353146156, 2832.3910359272854, 3166.699163579456, 3174.5238214267815, 28160.577591336147, 28557.714422855923, 28581.71418285811, 29095.56356654631, 29361.559576606156, 3048.527478240876, 3075.7078077582596, 3097.519884417919, 3099.7210251077286, 3127.0, 215624.0, 216045.0, 216374.91812540995, 218066.0, 218135.0, 48626.27060594094, 50177.24734128991, 52120.739396303536, 52874.206886896725, 53252.73373633107, 48041.5195848044, 48236.27645585249, 48407.757961209965, 48507.27239091346, 48593.0, 11851.762964740657, 11949.64151075469, 12074.75850483003, 12088.274703517816, 12095.516179352904, 9172.587233574372, 9212.907870921339, 9225.308101892386, 9228.123328283802, 9232.630694772268, 17923.37268195607, 18044.27822887096, 18056.819431805776, 18134.183961721756, 18149.0, 7249.456290778213, 7441.925580744231, 7508.962455187689, 7523.510971786816, 7594.886076708854, 819.6967122164718, 868.774118729135, 907.9909200908038, 979.647326962293, 1006.2352612014921, 26472.735272647027, 26682.19953401401, 26837.194884153505, 26919.461610768067, 26939.326516836845, 934.509382574154, 968.138356862393, 973.5278389980854, 1003.2926786615419, 1053.510117795229, 13656.863431365759, 13771.380287886868, 13822.0, 13856.515021974183, 13959.86040139606, 299095.0, 305925.0, 307025.0, 307063.0, 307981.0, 47319.763401182776, 47759.5224047762, 47890.52109478931, 47922.0, 47928.28107578389, 1198.2211562484456, 1199.0227964209141, 1204.8915597596258, 1205.4635687119148, 1209.915305928594, 25713.357166070997, 27033.72966270312, 27247.0, 27290.590641140003, 29798.8510057457, 42718.0, 43195.13609727725, 43296.350554742334, 43305.783471082446, 43419.56580434282, 244744.0, 248228.0, 248768.0, 248951.0, 249564.0, 32761.34477310488, 32782.83608581942, 34752.826235868655, 35606.710770875776, 39345.60654393419, 31701.0, 31722.68277317197, 36750.0, 37882.810585948, 39021.60978390293, 33197.83401082979, 33766.15584610404, 34873.30253394867, 34912.65087349094, 35298.470522941665, 33868.83065584656, 34005.48991765076, 34592.65407345995, 34661.0, 34710.47934281038, 31492.685073148976, 32380.35239295248, 33458.49812252769, 34073.148171295914, 34465.48301775425, 28781.0, 33507.0, 35547.46678799872, 35870.461943071394, 36163.27673446569, 23950.401239969142, 24287.0, 24457.177021573698, 24611.753882460947, 24929.501409971337], "unit": "ms", "name": "ext.html", "value": 17152.61050394608}, {"lowerIsBetter": false, "replicates": [337.65896444590965, 338.0787354459099, 339.37046778226403, 340.57938446019176, 345.123386598041, 11932.821007684892, 12286.01711863051, 14965.850341496582, 15149.621259468518, 15518.379264829407, 10728.570857165703, 13503.459861605525, 13799.724005519909, 14253.0, 14257.429702811902, 4678.368420263255, 4771.475137734847, 4941.530554597316, 5154.871128221787, 5160.587153027749, 5123.513266239701, 5147.6911385317, 5148.897022059557, 5154.175331946889, 5165.380154381461, 5108.974455127719, 5125.487451254882, 5128.102582048145, 5133.435322114565, 6375.266844312894, 6470.061841033047, 6498.220213574354, 6501.0898474213645, 6503.544751867371, 6509.316521765218, 6127.142200091991, 6219.315875253718, 6236.532260080512, 6298.401651843067, 6301.054841773725, 21295.893520532452, 21367.252146174964, 21499.0, 21862.45343866416, 21900.89049554742, 1910.5796724720678, 1957.3932081054777, 1958.0894883879064, 1994.3518356534184, 2026.7973202679761, 13601.0, 13759.38082786277, 13760.862391376058, 13992.160470371708, 14359.210243436606, 1834.2662934826044, 1861.3578315481138, 1877.3710806879712, 1903.9428817135508, 1943.1644392911044, 57186.428135718525, 60101.699491502266, 60336.39663603352, 61246.08130878085, 61474.0, 14984.0, 15169.62075948088, 15179.772303415457, 15194.924025379802, 15207.31567079484, 18186.727199092024, 18764.71852922207, 19755.0, 22325.77674223237, 22395.44011399728, 7186.496945213889, 7355.190928997806, 7425.740099096506, 7509.774706758806, 7576.052993375828, 5840.766369345263, 5936.465718085306, 5998.670073146019, 6024.3072046714315, 6082.878342433127, 7192.136943566806, 7232.20445750967, 7245.601491917995, 7252.129744430702, 7256.455765817479, 2809.9859500702364, 2920.72253135956, 2921.6055832462343, 2926.8877826425824, 2980.1390664961446, 707.8407358344331, 728.0317178153043, 738.3281214095148, 819.1890028871375, 842.9452085614415, 14580.708385832224, 14583.562493125222, 14975.625609359853, 15017.849821501644, 15019.624509387353, 755.8412733326063, 818.562039434378, 824.8369798583968, 824.9340052795762, 932.6222879733718, 7623.847523049619, 8473.322134229247, 8694.652213911373, 8831.867521987175, 8922.910770892338, 493992.0, 499233.0, 516396.0, 520495.0, 532367.0, 52480.47519524832, 56785.716071420204, 71542.0, 71812.0, 71829.64085179644, 928.6424726480353, 954.4321128928276, 961.423146112327, 961.6441916490943, 1074.0387353318893, 14128.081674691111, 14195.290235487977, 14207.431702731776, 14263.500777472738, 14548.563543093724, 27825.0, 28566.42867142687, 30173.09480715582, 31870.52194217042, 31955.201119972186, 37599.81200093982, 37926.0, 37948.430773538974, 38262.42606360962, 38407.42388864225, 8699.13008699125, 8850.424722393023, 8864.246539044254, 9020.503872287087, 9035.683751068682, 16218.594535136715, 16271.0, 16431.917840410722, 16534.09062501574, 16745.581360466087, 13495.662608434868, 13530.526431575241, 13600.727985440039, 13950.162990220619, 14046.087004344685, 13153.06759965013, 13239.801402979156, 13662.590122296348, 13701.931490342484, 13712.17726936387, 13977.860221397656, 14013.5095271665, 14100.0, 14271.286435677966, 14348.06737562055, 8539.487630742175, 8584.527850968258, 8601.0, 8632.61153248118, 8920.910790892267, 11930.582429614922, 12600.495980161058, 13639.680524595218, 13841.238731869844, 14095.365708542935], "unit": "ms", "name": "jquery.html", "value": 8856.558856115415}, {"lowerIsBetter": false, "replicates": [1356.3353956561282, 1373.931303434828, 1398.4336343780767, 1622.910739909305, 1690.0, 5522.392536820951, 6535.085088087666, 6765.763198288061, 6793.490488213379, 6804.285550017251, 6898.206706228772, 6979.685914133864, 6996.335348141931, 7009.5794252344895, 7077.186123595788, 1734.0, 1760.3838656470261, 1765.152726691189, 2073.9170433182694, 2121.501447159916, 1807.6836553603132, 1815.1105958080577, 2087.8538502304846, 2119.586680597284, 2124.957500849982, 2065.607534568435, 2074.4917495213695, 2077.345636124616, 2079.1267667579577, 2081.8230450411734, 1971.053894130818, 2006.4682859042366, 2008.9497762555907, 2014.869033512817, 2016.0323044938439, 2037.9388618341325, 2046.3042565527792, 2060.9896950515304, 2061.051916118587, 2086.248950377863, 6887.6556172191695, 6919.411849992756, 6955.965220173917, 6958.756443524503, 6964.860702785966, 4122.6083522065355, 4163.875083747493, 4183.686223533216, 4186.727862688916, 4189.183109293689, 2753.408017276275, 2793.888244470219, 2849.2449500882076, 2904.143277733074, 2911.213972227487, 874.5015341255423, 877.9165979231963, 879.4327658660193, 896.1486587741606, 921.5208091792231, 9624.181944534723, 9626.95186524063, 9633.662821801203, 9651.9034809651, 9663.420194788265, 3854.4603755473695, 3903.375459926398, 3949.54580223278, 3952.782596957195, 3958.247932892741, 8300.916990830014, 8316.417850750511, 8350.540720260444, 8353.498790072494, 8367.874481882776, 4049.919001619951, 4059.1475790083823, 4074.572169922175, 4078.163976384834, 4082.714210005271, 3682.963170368316, 3685.1155722626377, 3687.2625474905126, 3694.3165514379925, 3699.315626609086, 3408.2672225471147, 3452.723782097426, 3476.0614634048666, 3478.826058697055, 3486.8667683003127, 959.0936564946059, 974.2741657465234, 1074.8172810622214, 1085.4247248958065, 1087.858578384805, 696.019823601852, 706.0080586775589, 706.2090458686304, 706.3960313931617, 723.5513981331608, 6330.778422755181, 6401.9039714404325, 6403.903941440882, 6409.55133140685, 6426.74293028283, 989.3766926836047, 1009.0615727373466, 1009.2884516415909, 1019.7297716105238, 1032.6643840751785, 4878.658493905393, 4880.560749532559, 4981.0, 4981.427135879348, 4987.700737955662, 8165.959170204111, 8301.2943899768, 8413.70552030676, 8431.620577074047, 8439.493630382074, 8100.554469504234, 8279.006519217612, 8349.958250208832, 8352.081271060179, 8354.832903342021, 6394.552381333262, 6396.2964073951825, 6449.032645103272, 6458.22501299847, 6475.222973243147, 5974.492168165754, 5976.731047102804, 6007.909881351696, 6084.847878803065, 6094.542909281733, 7327.706891724271, 7387.519811212254, 7434.442416818868, 7469.775906722807, 7491.8501629966, 7546.886796697944, 7748.7675369739, 7749.7675069748, 7768.223177682186, 7784.610769461618, 6033.607815491979, 6117.969410153099, 6127.14220009208, 6130.0, 6132.264128304632, 6405.967970160119, 6465.903011454738, 6486.902696459462, 6487.026945958144, 6491.05879647439, 4888.877778055435, 5967.671778052075, 5977.46202841729, 6116.755329786936, 6160.3223645398075, 6111.113888486234, 6120.540959427972, 6122.112293717475, 6144.262688477412, 6190.659513726789, 5963.2844058713235, 5983.880322393615, 5996.910046349221, 5999.160117583455, 5999.1901093351835, 5627.324721033338, 5648.858778530405, 5675.035244008446, 5688.11834165705, 5700.315962084411, 5774.595778295479, 5819.621724587888, 5821.0, 5823.854403639943, 5834.970825145847], "unit": "ms", "name": "mootools.html", "value": 3935.4177682187546}, {"lowerIsBetter": false, "replicates": [311.1583167531826, 313.98273094979766, 314.2928411075081, 317.9443597370461, 318.59379291403445, 5306.355029940716, 5414.566834653228, 5431.864203394917, 5433.755481003354, 5453.318335208099, 5358.785648574052, 5364.409914909357, 5376.247325374451, 5379.246905433232, 5380.784768609251, 3978.8408463661417, 4072.694547908904, 4201.243776120297, 4202.096549241913, 4202.516710578292, 4060.817263223162, 4074.0222346636892, 4137.089840235159, 4140.81366338514, 4220.240356735786, 4150.252954468195, 4151.211269858717, 4161.396597493362, 4174.144300418422, 4174.290370636983, 3916.941245881314, 3995.720299579031, 4031.153457773871, 4167.9583204167875, 4169.958300416987, 3687.1888184599347, 3688.188598508324, 3690.1143725505685, 3691.3724666806706, 3694.907627309312, 5139.820106296299, 5154.690718556861, 5154.742262886878, 5160.432352441266, 5175.171972484384, 4825.179719447668, 4831.4685384607665, 4831.782569784368, 4832.782524786393, 4841.70949743013, 5510.1459273812225, 5651.095824668033, 5658.122990936411, 5662.943370566324, 5667.4049224831215, 4045.7167998240134, 4047.494063242095, 4048.736832105933, 4048.7975601219823, 4050.311447054008, 5942.494887934531, 5943.049112142036, 5951.22634057574, 5954.2259506264345, 5955.404459554054, 4174.352975288835, 4176.331786914079, 4176.519700234512, 4176.665866730655, 4182.435371224907, 4121.8969525762095, 4218.7468751874985, 4242.087951090469, 4245.681573881971, 4259.893502662396, 4803.735794531334, 4813.253945638432, 4814.085323788469, 4814.085323788469, 4818.012307476959, 5675.404082571271, 5681.857953551194, 5685.147227915846, 5689.857753556194, 5690.459406356389, 1476.4094362255184, 1496.6408062065027, 1497.468398718461, 1497.5806774103269, 1497.8951473396758, 1022.7392015036119, 1027.1628622672497, 1038.7247379444452, 1041.9635312764017, 1057.117307048623, 4973.104841128559, 4974.726390048582, 4987.251912213197, 4992.450830408652, 4997.125503036954, 5834.474897259267, 5863.706814659336, 5869.442402971711, 5873.207117039145, 5875.059990401601, 4964.801407943642, 4972.353594032753, 4978.10394129053, 4981.12830254704, 4988.90022199554, 2925.3564215872475, 3006.7293943545187, 3115.750739940799, 3135.576697145856, 3175.0, 5493.670379777226, 5510.641808282448, 5590.301212348457, 5592.105263157875, 5595.832125036255, 6072.696365181723, 6084.452399284086, 6096.786612468542, 6100.298465676504, 6105.694715264219, 5554.638948468418, 5566.693831839207, 5567.471090246501, 5571.136473846398, 5573.526250268692, 5716.742746576331, 5888.234529511136, 5904.498117660047, 5905.704714764331, 5907.2911250650195, 5783.768649253982, 5790.10253410722, 5790.594658373873, 5794.101914203306, 5803.187553742564, 5531.668099914018, 5537.640053396516, 5538.892221555786, 5542.974549708317, 5548.944510554843, 3897.8635747748694, 4000.1999600079516, 4041.1917616476235, 4043.85846495383, 4046.008727861693, 5811.389804070512, 5812.244408226903, 5814.622049566934, 5816.534677225896, 5818.040023396262, 5600.299962504687, 5606.915896261477, 5607.243022191952, 5610.4670056344585, 5613.46672066153, 5596.440355964533, 5611.551075913835, 5616.634918730269, 5635.746391412478, 5637.633553818989, 5348.491893270133, 5467.562594992471, 5478.616496845182, 5485.807996720096, 5487.64330318528, 5652.604317697722, 5658.434156584309, 5665.235193248858, 5667.518260947865, 5670.716464176857, 5382.4886635769535, 5465.617406781487, 5515.062439385234, 5591.916121258103, 5605.663660180402], "unit": "ms", "name": "prototype.html", "value": 4267.9582530495245}, {"lowerIsBetter": false, "replicates": [699.5802518488904, 716.4733920568383, 724.1310427487014, 734.408800915263, 737.4174402222245, 11165.665030049102, 11562.190646654737, 11566.47950842211, 11578.073754099672, 11606.941965290183, 10943.616973405933, 11090.5563777449, 11098.55605775768, 11099.500522476488, 11116.444177791098, 752.4619896773805, 766.6281853301144, 766.643510767493, 766.84279722657, 767.0603510699376, 612.8130920069377, 617.8517155882578, 761.8285885675706, 777.4985134588215, 778.5717855179657, 808.7412028150994, 809.6882700160451, 817.9100298967109, 818.4884447220487, 819.0826274572457, 630.8832865919774, 637.7959053103009, 808.4138999225573, 810.6433169405443, 811.5130921447114, 473.7418107131622, 473.7891638220993, 474.0211463328216, 588.5732843688335, 598.3268822574604, 11832.881671183264, 11956.0, 11971.820422693667, 12006.939965300206, 12016.939915300454, 10629.946850265776, 10760.515776789985, 10869.83695244572, 11253.774924501546, 11435.942820285929, 8701.206671124726, 8837.955810220972, 8861.424007439497, 8975.0, 8980.955095224548, 3270.7056364927034, 3300.3729291434793, 3303.3723592517345, 3331.566896303489, 3395.9830200849083, 41018.38472422916, 41090.589094108975, 41151.1769764606, 41202.38196427056, 41264.38103428481, 9592.712218633453, 9678.612855485702, 9708.757281067888, 9775.853362199572, 9858.457784821903, 16397.754033689504, 16523.256453459624, 16580.336786528405, 16608.16959152062, 16651.50045498637, 6135.018397056449, 6149.262088549313, 6162.26052873658, 6195.535334849814, 6348.428641422294, 3300.290437555937, 3318.601767787881, 3329.9500507492407, 3351.564296641421, 3369.427197376452, 2767.8892844286, 2790.3582176099612, 2791.371941313229, 2797.692253852075, 2799.9160025199276, 461.6399208617284, 470.8893410048636, 481.0331234219175, 481.1387616167022, 483.0869656349502, 420.8548050922427, 421.090444639577, 429.46317103620476, 429.51893878855884, 432.22200039928003, 7246.456515761339, 7544.6227688616445, 7574.394048476109, 7634.198409166957, 7659.080910290801, 433.59025720694274, 468.27183729300583, 496.9602431805447, 513.2762804445714, 524.6825670469311, 3293.4730443128983, 3771.792551409644, 3783.3379158647126, 3822.9617703822605, 3917.941230881539, 50254.49745502571, 51170.48829511657, 51257.48742512602, 51304.74347628238, 51308.486915131114, 44462.77768611201, 45098.32352514715, 45174.096518069455, 45809.0, 46364.76817615958, 41738.79130604388, 42382.36426453606, 43589.56410435855, 43691.78154109273, 43874.0, 6980.0, 7143.892841607276, 8072.4349295548745, 8180.304674102768, 8393.37049721261, 32911.0, 33346.33307333888, 33960.83019584886, 34209.82895085509, 34464.138396540286, 38809.2238155241, 41040.58959410368, 41703.374449382674, 41928.161436771705, 42003.36994945017, 9488.33581649278, 9555.952220239133, 9716.0, 9835.85246221293, 9892.911779704371, 10688.25182237236, 10722.839157412489, 10734.194935380034, 10762.40806755636, 10882.183836212474, 9978.750531236778, 10300.0, 10409.68770936873, 10446.112080473245, 10764.623238186627, 10244.64143754965, 10281.948590257001, 10301.536430860479, 10318.587256509656, 10321.122704570196, 10397.220208484243, 10523.789524209626, 10567.94716026415, 10607.363558186533, 10754.51604677807, 7978.481398709066, 8131.959340203498, 8146.83706325882, 8469.957650211709, 8479.0, 8192.426530143071, 8524.262630803476, 8584.313254939714, 8749.343799214957, 8762.506373857159], "unit": "ms", "name": "yui.html", "value": 5538.770082755214}], "name": "dromaeo_css"}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 113.0, 106.0, 112.0, 113.0, 113.0, 101.0, 113.0, 111.0, 104.0], "unit": "ms", "name": "ai-astar", "value": 109.7}, {"lowerIsBetter": true, "replicates": [156.0, 129.0, 153.0, 170.0, 134.0, 158.0, 161.0, 133.0, 180.0, 133.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.7}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 160.0, 161.0, 162.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 89.0, 88.0, 75.0, 73.0, 78.0, 122.0, 96.0, 76.0], "unit": "ms", "name": "audio-fft", "value": 84.1}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 126.0, 93.0, 96.0, 94.0, 136.0, 94.0, 94.0, 144.0], "unit": "ms", "name": "audio-oscillator", "value": 106.6}, {"lowerIsBetter": true, "replicates": [110.0, 109.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [147.0, 148.0, 146.0, 146.0, 146.0, 147.0, 146.0, 146.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 71.0, 70.0, 72.0, 71.0, 71.0, 71.0, 80.0, 70.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 71.4}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.1}, {"lowerIsBetter": true, "replicates": [84.0, 83.0, 85.0, 83.0, 83.0, 86.0, 87.0, 83.0, 85.0, 83.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 84.2}, {"lowerIsBetter": true, "replicates": [121.0, 120.0, 121.0, 120.0, 118.0, 128.0, 119.0, 127.0, 115.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 121.7}, {"lowerIsBetter": true, "replicates": [138.0, 143.0, 147.0, 146.0, 144.0, 154.0, 152.0, 143.0, 147.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.9}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 68.0, 74.0, 70.0, 68.0, 71.0, 67.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.1}], "name": "kraken"}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.52780519907864], "unit": "score", "name": "Richards", "value": 214.56555600000002}, {"lowerIsBetter": false, "replicates": [192.23375624759709], "unit": "score", "name": "DeltaBlue", "value": 343.9458360000001}, {"lowerIsBetter": false, "replicates": [277.85495971103086], "unit": "score", "name": "Encrypt", "value": 957.9854189999998}, {"lowerIsBetter": false, "replicates": [5180.412371134021], "unit": "score", "name": "Decrypt", "value": 51.38220298507464}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [800.0], "unit": "score", "name": "Earley", "value": 833.0787499999997}, {"lowerIsBetter": false, "replicates": [12243.90243902439], "unit": "score", "name": "Boyer", "value": 54.4322370517928}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [593.4718100890208], "unit": "score", "name": "Splay", "value": 137.31233500000002}, {"lowerIsBetter": false, "replicates": [4830.917874396136], "unit": "score", "name": "NavierStokes", "value": 307.1879999999999}], "name": "v8_7"}]} 04:08:40 INFO - RETURN: dromaeo_css: 6357.44 04:08:40 INFO - RETURN: kraken: 1523.40 04:08:40 INFO - RETURN: v8_7: 19846.67 04:08:40 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19846.67"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1523.40"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6357.44"}}} 04:08:40 INFO - Return code: 0 04:08:40 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:08:40 INFO - # TBPL SUCCESS # 04:08:40 INFO - Running post-action listener: _resource_record_post_action 04:08:40 INFO - Running post-run listener: _resource_record_post_run 04:08:41 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 0; Write bytes: 514060288; Read time: 0; Write time: 475284 04:08:41 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 239116288; Read time: 0; Write time: 296856 04:08:41 INFO - run-tests - Wall time: 1218s; CPU: 13.0%; Read bytes: 0; Write bytes: 270979072; Read time: 0; Write time: 177416 04:08:41 INFO - Running post-run listener: _upload_blobber_files 04:08:41 INFO - Blob upload gear active. 04:08:41 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 04:08:41 INFO - Copying logs to upload dir... 04:08:41 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1266.541581 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2015-11-25 04:08:41.066635) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:08:41.069781) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010314 build_url: 'https://queue.taskcluster.net/v1/task/aA98hS3OTwifx9dqT9JFSg/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 04:08:41.121465) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:08:41.121781) ========= 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=23f5739b2d6aa5d9caf5c428000001ae-1448451241.681143-1973454312 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004565 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 04:08:41.171162) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 04:08:41.171533) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 04:08:41.171820) ========= ========= Total master_lag: 0.23 =========