builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-047 starttime: 1448461413.26 results: success (0) buildid: 20151125050133 builduid: 6602b3fb457a4f7897e6bb2ed51c0733 revision: 75fc4684b2aac50fb8ea568c679529be710d46f4 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.255889) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.259355) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.259694) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006532 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.288267) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.291631) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.307805) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.308076) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004667 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.361644) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.361954) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.362324) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.362609) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-25 06:23:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 74.0M=0s 2015-11-25 06:23:33 (74.0 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.184554 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.565483) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.565808) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015104 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:33.615081) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 06:23:33.618491) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 75fc4684b2aac50fb8ea568c679529be710d46f4 --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 75fc4684b2aac50fb8ea568c679529be710d46f4 --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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-25 06:23:33,948 truncating revision to first 12 chars 2015-11-25 06:23:33,948 Setting DEBUG logging. 2015-11-25 06:23:33,948 attempt 1/10 2015-11-25 06:23:33,948 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/75fc4684b2aa?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-25 06:23:34,844 unpacking tar archive at: b2g-inbound-75fc4684b2aa/testing/mozharness/ program finished with exit code 0 elapsedTime=1.206049 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-25 06:23:34.837167) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:34.840662) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:34.853038) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:34.853410) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-25 06:23:34.853897) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-25 06:23:34.854177) ========= /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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 06:23:35 INFO - MultiFileLogger online at 20151125 06:23:35 in /builds/slave/test 06:23:35 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 06:23:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 06:23:35 INFO - {'append_to_log': False, 06:23:35 INFO - 'base_work_dir': '/builds/slave/test', 06:23:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 06:23:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 06:23:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 06:23:35 INFO - 'buildbot_json_path': 'buildprops.json', 06:23:35 INFO - 'config_files': ('talos/linux_config.py',), 06:23:35 INFO - 'default_actions': ('clobber', 06:23:35 INFO - 'read-buildbot-config', 06:23:35 INFO - 'download-and-extract', 06:23:35 INFO - 'populate-webroot', 06:23:35 INFO - 'create-virtualenv', 06:23:35 INFO - 'install', 06:23:35 INFO - 'run-tests'), 06:23:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 06:23:35 INFO - 'download_minidump_stackwalk': True, 06:23:35 INFO - 'download_symbols': 'ondemand', 06:23:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 06:23:35 INFO - 'tooltool.py': '/tools/tooltool.py', 06:23:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 06:23:35 INFO - '/tools/misc-python/virtualenv.py')}, 06:23:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 06:23:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 06:23:35 INFO - 'installer_path': 'installer.exe', 06:23:35 INFO - 'log_level': 'info', 06:23:35 INFO - 'log_name': 'talos', 06:23:35 INFO - 'log_to_console': True, 06:23:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 06:23:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 06:23:35 INFO - 'opt_config_files': (), 06:23:35 INFO - 'pip_index': False, 06:23:35 INFO - 'sps_profile': False, 06:23:35 INFO - 'sps_profile_interval': 0, 06:23:35 INFO - 'suite': 'dromaeojs', 06:23:35 INFO - 'system_bits': '64', 06:23:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 06:23:35 INFO - 'title': 'talos-linux64-ix-047', 06:23:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 06:23:35 INFO - 'use_talos_json': True, 06:23:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 06:23:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 06:23:35 INFO - 'work_dir': 'build'} 06:23:35 INFO - ##### 06:23:35 INFO - ##### Running clobber step. 06:23:35 INFO - ##### 06:23:35 INFO - Running pre-action listener: _resource_record_pre_action 06:23:35 INFO - Running main action method: clobber 06:23:35 INFO - rmtree: /builds/slave/test/build 06:23:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 06:23:36 INFO - Running post-action listener: _resource_record_post_action 06:23:36 INFO - ##### 06:23:36 INFO - ##### Running read-buildbot-config step. 06:23:36 INFO - ##### 06:23:36 INFO - Running pre-action listener: _resource_record_pre_action 06:23:36 INFO - Running main action method: read_buildbot_config 06:23:36 INFO - Using buildbot properties: 06:23:36 INFO - { 06:23:36 INFO - "properties": { 06:23:36 INFO - "buildnumber": 288, 06:23:36 INFO - "product": "firefox", 06:23:36 INFO - "script_repo_revision": "production", 06:23:36 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 06:23:36 INFO - "repository": "", 06:23:36 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 06:23:36 INFO - "buildid": "20151125050133", 06:23:36 INFO - "slavename": "talos-linux64-ix-047", 06:23:36 INFO - "pgo_build": "False", 06:23:36 INFO - "basedir": "/builds/slave/test", 06:23:36 INFO - "project": "", 06:23:36 INFO - "platform": "ubuntu64_hw", 06:23:36 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 06:23:36 INFO - "slavebuilddir": "test", 06:23:36 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 06:23:36 INFO - "branch": "b2g-inbound", 06:23:36 INFO - "repo_path": "integration/b2g-inbound", 06:23:36 INFO - "stage_platform": "linux64", 06:23:36 INFO - "builduid": "6602b3fb457a4f7897e6bb2ed51c0733", 06:23:36 INFO - "revision": "75fc4684b2aac50fb8ea568c679529be710d46f4" 06:23:36 INFO - }, 06:23:36 INFO - "sourcestamp": { 06:23:36 INFO - "repository": "", 06:23:36 INFO - "hasPatch": false, 06:23:36 INFO - "project": "", 06:23:36 INFO - "branch": "b2g-inbound-linux64-talos", 06:23:36 INFO - "changes": [ 06:23:36 INFO - { 06:23:36 INFO - "category": null, 06:23:36 INFO - "files": [ 06:23:36 INFO - { 06:23:36 INFO - "url": null, 06:23:36 INFO - "name": "https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 06:23:36 INFO - } 06:23:36 INFO - ], 06:23:36 INFO - "repository": "", 06:23:36 INFO - "rev": "75fc4684b2aac50fb8ea568c679529be710d46f4", 06:23:36 INFO - "who": "cbook@mozilla.com", 06:23:36 INFO - "when": 1448461377, 06:23:36 INFO - "number": 6705758, 06:23:36 INFO - "comments": "Merge mozilla-central to b2g-inbound", 06:23:36 INFO - "project": "", 06:23:36 INFO - "at": "Wed 25 Nov 2015 06:22:57", 06:23:36 INFO - "branch": "b2g-inbound-linux64-talos", 06:23:36 INFO - "revlink": "", 06:23:36 INFO - "properties": [ 06:23:36 INFO - [ 06:23:36 INFO - "buildid", 06:23:36 INFO - "20151125050133", 06:23:36 INFO - "Change" 06:23:36 INFO - ], 06:23:36 INFO - [ 06:23:36 INFO - "builduid", 06:23:36 INFO - "6602b3fb457a4f7897e6bb2ed51c0733", 06:23:36 INFO - "Change" 06:23:36 INFO - ], 06:23:36 INFO - [ 06:23:36 INFO - "pgo_build", 06:23:36 INFO - "False", 06:23:36 INFO - "Change" 06:23:36 INFO - ] 06:23:36 INFO - ], 06:23:36 INFO - "revision": "75fc4684b2aac50fb8ea568c679529be710d46f4" 06:23:36 INFO - } 06:23:36 INFO - ], 06:23:36 INFO - "revision": "75fc4684b2aac50fb8ea568c679529be710d46f4" 06:23:36 INFO - } 06:23:36 INFO - } 06:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 06:23:36 INFO - Running post-action listener: _resource_record_post_action 06:23:36 INFO - ##### 06:23:36 INFO - ##### Running download-and-extract step. 06:23:36 INFO - ##### 06:23:36 INFO - Running pre-action listener: _resource_record_pre_action 06:23:36 INFO - Running main action method: download_and_extract 06:23:36 INFO - mkdir: /builds/slave/test/build/tests 06:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:36 INFO - https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 06:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/test_packages.json 06:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/test_packages.json 06:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 06:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 06:23:36 INFO - Downloaded 1302 bytes. 06:23:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 06:23:36 INFO - Using the following test package requirements: 06:23:36 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 06:23:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'jsshell-linux-x86_64.zip'], 06:23:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 06:23:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 06:23:36 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 06:23:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 06:23:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 06:23:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 06:23:36 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 06:23:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 06:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:36 INFO - https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:40 INFO - Downloaded 21508050 bytes. 06:23: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 06:23:40 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23: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 06:23:41 INFO - Return code: 0 06:23: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 06:23: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')]} 06:23:41 INFO - https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 06:23:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:42 INFO - Downloaded 21508050 bytes. 06:23:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 06:23:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 06:23:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 06:23:43 INFO - Return code: 0 06:23:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:43 INFO - https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 06:23:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:44 INFO - Downloaded 11131717 bytes. 06:23:44 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 06:23:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 06:23:44 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 06:23:45 INFO - Return code: 0 06:23: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')]} 06:23:45 INFO - https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 06:23:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:23:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:23:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:23:47 INFO - Downloaded 56843612 bytes. 06:23:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:23:47 INFO - mkdir: /builds/slave/test/properties 06:23:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 06:23:47 INFO - Writing to file /builds/slave/test/properties/build_url 06:23:47 INFO - Contents: 06:23:47 INFO - build_url:https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 06:23:47 INFO - Running post-action listener: _resource_record_post_action 06:23:47 INFO - Running post-action listener: set_extra_try_arguments 06:23:47 INFO - ##### 06:23:47 INFO - ##### Running populate-webroot step. 06:23:47 INFO - ##### 06:23:47 INFO - Running pre-action listener: _resource_record_pre_action 06:23:47 INFO - Running main action method: populate_webroot 06:23:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 06:23:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 06:23:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 06:23:47 INFO - '../fennec_ids.txt'], 06:23:47 INFO - 'tests': ['tcheck2']}, 06:23:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 06:23:47 INFO - '--tppagecycles', 06:23:47 INFO - '7'], 06:23:47 INFO - 'tests': ['tsvgm']}}, 06:23:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 06:23:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 06:23:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:23:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 06:23:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 06:23:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'tests': ['damp', 'tps']}, 06:23:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['damp', 'tps']}, 06:23:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 06:23:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 06:23:47 INFO - 'other': {'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'other_l64': {'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'other_nol64': {'tests': ['a11yr', 06:23:47 INFO - 'ts_paint', 06:23:47 INFO - 'tpaint', 06:23:47 INFO - 'sessionrestore', 06:23:47 INFO - 'sessionrestore_no_auto_restore']}, 06:23:47 INFO - 'svgr': {'tests': ['tsvgx', 06:23:47 INFO - 'tsvgr_opacity', 06:23:47 INFO - 'tart', 06:23:47 INFO - 'tscrollx', 06:23:47 INFO - 'cart']}, 06:23:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['tsvgx', 06:23:47 INFO - 'tsvgr_opacity', 06:23:47 INFO - 'tart', 06:23:47 INFO - 'tscrollx', 06:23:47 INFO - 'cart']}, 06:23:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'tests': ['tp5o']}, 06:23:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'talos_options': ['--e10s'], 06:23:47 INFO - 'tests': ['tp5o']}, 06:23:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'talos_options': ['--xperf_path', 06:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:47 INFO - 'tests': ['tp5n']}, 06:23:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 06:23:47 INFO - 'talos_options': ['--e10s', 06:23:47 INFO - '--xperf_path', 06:23:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 06:23:47 INFO - 'tests': ['tp5n']}}, 06:23:47 INFO - 'talos.zip': {'path': '', 06:23:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 06:23:47 INFO - Running post-action listener: _resource_record_post_action 06:23:47 INFO - ##### 06:23:47 INFO - ##### Running create-virtualenv step. 06:23:47 INFO - ##### 06:23:47 INFO - Running pre-action listener: _resource_record_pre_action 06:23:47 INFO - Running main action method: create_virtualenv 06:23:47 INFO - Creating virtualenv /builds/slave/test/build/venv 06:23: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 06:23:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 06:23:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 06:23:47 INFO - Using real prefix '/usr' 06:23:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 06:23:47 INFO - Installing distribute.............................................................................................................................................................................................done. 06:23:49 INFO - Installing pip.................done. 06:23:49 INFO - Return code: 0 06:23:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 06:23:49 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')]} 06:23:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:49 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')]} 06:23:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:49 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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:23:49 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 06:23:49 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 06:23:49 INFO - Using env: {'DISPLAY': ':0', 06:23:49 INFO - 'HOME': '/home/cltbld', 06:23:49 INFO - 'LANG': 'en_US.UTF-8', 06:23:49 INFO - 'LANGUAGE': 'en_US:en', 06:23:49 INFO - 'LOGNAME': 'cltbld', 06:23:49 INFO - 'MAIL': '/var/mail/cltbld', 06:23:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:49 INFO - 'MOZ_NO_REMOTE': '1', 06:23:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:49 INFO - 'NO_EM_RESTART': '1', 06:23:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:49 INFO - 'PWD': '/builds/slave/test', 06:23:49 INFO - 'SHELL': '/bin/bash', 06:23:49 INFO - 'SHLVL': '1', 06:23:49 INFO - 'TERM': 'linux', 06:23:49 INFO - 'TMOUT': '86400', 06:23:49 INFO - 'USER': 'cltbld', 06:23:49 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:23:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:49 INFO - '_': '/tools/buildbot/bin/python'} 06:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23: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 06:23:50 INFO - Cleaning up... 06:23:50 INFO - Return code: 0 06:23:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:23: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 06:23: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 06:23:50 INFO - Using env: {'DISPLAY': ':0', 06:23:50 INFO - 'HOME': '/home/cltbld', 06:23:50 INFO - 'LANG': 'en_US.UTF-8', 06:23:50 INFO - 'LANGUAGE': 'en_US:en', 06:23:50 INFO - 'LOGNAME': 'cltbld', 06:23:50 INFO - 'MAIL': '/var/mail/cltbld', 06:23:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:50 INFO - 'MOZ_NO_REMOTE': '1', 06:23:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:50 INFO - 'NO_EM_RESTART': '1', 06:23:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:50 INFO - 'PWD': '/builds/slave/test', 06:23:50 INFO - 'SHELL': '/bin/bash', 06:23:50 INFO - 'SHLVL': '1', 06:23:50 INFO - 'TERM': 'linux', 06:23:50 INFO - 'TMOUT': '86400', 06:23:50 INFO - 'USER': 'cltbld', 06:23:50 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:23:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:50 INFO - '_': '/tools/buildbot/bin/python'} 06:23:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:50 INFO - Downloading/unpacking psutil>=0.7.1 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 06:23:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 06:23:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 06:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:52 INFO - Installing collected packages: psutil 06:23:52 INFO - Running setup.py install for psutil 06:23:52 INFO - building 'psutil._psutil_linux' extension 06:23: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 06:23: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 06:23:52 INFO - building 'psutil._psutil_posix' extension 06:23: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 06:23: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 06:23:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 06:23:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 06:23:52 INFO - Successfully installed psutil 06:23:52 INFO - Cleaning up... 06:23:52 INFO - Return code: 0 06:23:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:23: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 06:23: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 06:23:52 INFO - Using env: {'DISPLAY': ':0', 06:23:52 INFO - 'HOME': '/home/cltbld', 06:23:52 INFO - 'LANG': 'en_US.UTF-8', 06:23:52 INFO - 'LANGUAGE': 'en_US:en', 06:23:52 INFO - 'LOGNAME': 'cltbld', 06:23:52 INFO - 'MAIL': '/var/mail/cltbld', 06:23:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:52 INFO - 'MOZ_NO_REMOTE': '1', 06:23:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:52 INFO - 'NO_EM_RESTART': '1', 06:23:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:52 INFO - 'PWD': '/builds/slave/test', 06:23:52 INFO - 'SHELL': '/bin/bash', 06:23:52 INFO - 'SHLVL': '1', 06:23:52 INFO - 'TERM': 'linux', 06:23:52 INFO - 'TMOUT': '86400', 06:23:52 INFO - 'USER': 'cltbld', 06:23:52 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:23:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:52 INFO - '_': '/tools/buildbot/bin/python'} 06:23:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 06:23:52 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 06:23:52 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 06:23:52 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 06:23:52 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 06:23:52 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 06:23:52 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 06:23:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 06:23:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 06:23:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 06:23: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) 06:23:54 INFO - Installing collected packages: mozsystemmonitor 06:23:54 INFO - Running setup.py install for mozsystemmonitor 06:23:54 INFO - Successfully installed mozsystemmonitor 06:23:54 INFO - Cleaning up... 06:23:54 INFO - Return code: 0 06:23:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 06:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 06:23:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:23:54 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 06:23:54 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 06:23:54 INFO - Using env: {'DISPLAY': ':0', 06:23:54 INFO - 'HOME': '/home/cltbld', 06:23:54 INFO - 'LANG': 'en_US.UTF-8', 06:23:54 INFO - 'LANGUAGE': 'en_US:en', 06:23:54 INFO - 'LOGNAME': 'cltbld', 06:23:54 INFO - 'MAIL': '/var/mail/cltbld', 06:23:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:54 INFO - 'MOZ_NO_REMOTE': '1', 06:23:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:54 INFO - 'NO_EM_RESTART': '1', 06:23:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:54 INFO - 'PWD': '/builds/slave/test', 06:23:54 INFO - 'SHELL': '/bin/bash', 06:23:54 INFO - 'SHLVL': '1', 06:23:54 INFO - 'TERM': 'linux', 06:23:54 INFO - 'TMOUT': '86400', 06:23:54 INFO - 'USER': 'cltbld', 06:23:54 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:23:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:54 INFO - '_': '/tools/buildbot/bin/python'} 06:23:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:55 INFO - Downloading/unpacking blobuploader==1.2.4 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:56 INFO - Downloading blobuploader-1.2.4.tar.gz 06:23:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 06:23:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 06:23:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 06:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 06:23:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23: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 06:23:57 INFO - Downloading docopt-0.6.1.tar.gz 06:23:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 06:23:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 06:23:57 INFO - Installing collected packages: blobuploader, requests, docopt 06:23:57 INFO - Running setup.py install for blobuploader 06:23:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 06:23:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 06:23:57 INFO - Running setup.py install for requests 06:23:57 INFO - Running setup.py install for docopt 06:23:57 INFO - Successfully installed blobuploader requests docopt 06:23:57 INFO - Cleaning up... 06:23:58 INFO - Return code: 0 06:23:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:23: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')]} 06:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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')]} 06:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:23: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:23: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 06:23: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 06:23:58 INFO - Using env: {'DISPLAY': ':0', 06:23:58 INFO - 'HOME': '/home/cltbld', 06:23:58 INFO - 'LANG': 'en_US.UTF-8', 06:23:58 INFO - 'LANGUAGE': 'en_US:en', 06:23:58 INFO - 'LOGNAME': 'cltbld', 06:23:58 INFO - 'MAIL': '/var/mail/cltbld', 06:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:23:58 INFO - 'MOZ_NO_REMOTE': '1', 06:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:23:58 INFO - 'NO_EM_RESTART': '1', 06:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:23:58 INFO - 'PWD': '/builds/slave/test', 06:23:58 INFO - 'SHELL': '/bin/bash', 06:23:58 INFO - 'SHLVL': '1', 06:23:58 INFO - 'TERM': 'linux', 06:23:58 INFO - 'TMOUT': '86400', 06:23:58 INFO - 'USER': 'cltbld', 06:23:58 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:23:58 INFO - '_': '/tools/buildbot/bin/python'} 06:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:23:58 INFO - Running setup.py (path:/tmp/pip-qcxC_j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:23:58 INFO - Running setup.py (path:/tmp/pip-p8WqQ7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:23:58 INFO - Running setup.py (path:/tmp/pip-WHAypE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:23:58 INFO - Running setup.py (path:/tmp/pip-Uf4HdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:23:58 INFO - Running setup.py (path:/tmp/pip-Drw2Fl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:23:58 INFO - Running setup.py (path:/tmp/pip-p0b6iy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:23:58 INFO - Running setup.py (path:/tmp/pip-eXMU5x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:23:58 INFO - Running setup.py (path:/tmp/pip-bR2bk2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:23:58 INFO - Running setup.py (path:/tmp/pip-4tPgze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:23:58 INFO - Running setup.py (path:/tmp/pip-OJRPUf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:23:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:23:58 INFO - Running setup.py (path:/tmp/pip-8eMqE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:23:59 INFO - Running setup.py (path:/tmp/pip-vu2Mep-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:23:59 INFO - Running setup.py (path:/tmp/pip-e27Y4m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:23:59 INFO - Running setup.py (path:/tmp/pip-UOmro5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:59 INFO - Running setup.py (path:/tmp/pip-fyHaFS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:23:59 INFO - Running setup.py (path:/tmp/pip-W6uk38-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:23:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:23:59 INFO - Running setup.py (path:/tmp/pip-YIXj0w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:23:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 06:23:59 INFO - Running setup.py install for manifestparser 06:23:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 06:23:59 INFO - Running setup.py install for mozcrash 06:23:59 INFO - Running setup.py install for mozdebug 06:23:59 INFO - Running setup.py install for mozdevice 06:23:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 06:23:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 06:23:59 INFO - Running setup.py install for mozfile 06:23:59 INFO - Running setup.py install for mozhttpd 06:24:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozinfo 06:24:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozInstall 06:24:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozleak 06:24:00 INFO - Running setup.py install for mozlog 06:24:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for moznetwork 06:24:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozprocess 06:24:00 INFO - Running setup.py install for mozprofile 06:24:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozrunner 06:24:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 06:24:00 INFO - Running setup.py install for mozscreenshot 06:24:01 INFO - Running setup.py install for moztest 06:24:01 INFO - Running setup.py install for mozversion 06:24:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 06:24:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 06:24:01 INFO - Cleaning up... 06:24:01 INFO - Return code: 0 06:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:24: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 06:24: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 06:24:01 INFO - Using env: {'DISPLAY': ':0', 06:24:01 INFO - 'HOME': '/home/cltbld', 06:24:01 INFO - 'LANG': 'en_US.UTF-8', 06:24:01 INFO - 'LANGUAGE': 'en_US:en', 06:24:01 INFO - 'LOGNAME': 'cltbld', 06:24:01 INFO - 'MAIL': '/var/mail/cltbld', 06:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:01 INFO - 'MOZ_NO_REMOTE': '1', 06:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:01 INFO - 'NO_EM_RESTART': '1', 06:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:01 INFO - 'PWD': '/builds/slave/test', 06:24:01 INFO - 'SHELL': '/bin/bash', 06:24:01 INFO - 'SHLVL': '1', 06:24:01 INFO - 'TERM': 'linux', 06:24:01 INFO - 'TMOUT': '86400', 06:24:01 INFO - 'USER': 'cltbld', 06:24:01 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:01 INFO - '_': '/tools/buildbot/bin/python'} 06:24:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 06:24:01 INFO - Running setup.py (path:/tmp/pip-ATkIaq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 06:24: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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 06:24:01 INFO - Running setup.py (path:/tmp/pip-RYd_fn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 06:24: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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 06:24:01 INFO - Running setup.py (path:/tmp/pip-UsAtiA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 06:24: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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 06:24:01 INFO - Running setup.py (path:/tmp/pip-5UJ3oB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 06:24: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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 06:24:01 INFO - Running setup.py (path:/tmp/pip-X3LSMw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 06:24: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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 06:24:01 INFO - Running setup.py (path:/tmp/pip-Spl_H0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 06:24:01 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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 06:24:01 INFO - Running setup.py (path:/tmp/pip-S_8LvG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 06:24:01 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)) 06:24:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 06:24:01 INFO - Running setup.py (path:/tmp/pip-GKFqxh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 06:24:02 INFO - Running setup.py (path:/tmp/pip-8GHRQ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 06:24:02 INFO - Running setup.py (path:/tmp/pip-jEaeLy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 06:24:02 INFO - Running setup.py (path:/tmp/pip-oocHFq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 06:24:02 INFO - Running setup.py (path:/tmp/pip-n0pwQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 06:24:02 INFO - Running setup.py (path:/tmp/pip-9c_4YH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 06:24:02 INFO - Running setup.py (path:/tmp/pip-8Mpeq0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 06:24:02 INFO - Running setup.py (path:/tmp/pip-XyJSeV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 06:24:02 INFO - Running setup.py (path:/tmp/pip-Ekm_dA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 06:24: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)) 06:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 06:24:02 INFO - Running setup.py (path:/tmp/pip-pRhRZi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:04 INFO - Downloading blessings-1.5.1.tar.gz 06:24: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 06:24:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 06:24:04 INFO - Installing collected packages: blessings 06:24:04 INFO - Running setup.py install for blessings 06:24:04 INFO - Successfully installed blessings 06:24:04 INFO - Cleaning up... 06:24:04 INFO - Return code: 0 06:24:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 06:24:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:04 INFO - Reading from file tmpfile_stdout 06:24:04 INFO - Current package versions: 06:24:04 INFO - argparse == 1.2.1 06:24:04 INFO - blessings == 1.5.1 06:24:04 INFO - blobuploader == 1.2.4 06:24:04 INFO - docopt == 0.6.1 06:24:04 INFO - manifestparser == 1.1 06:24:04 INFO - mozInstall == 1.12 06:24:04 INFO - mozcrash == 0.16 06:24:04 INFO - mozdebug == 0.1 06:24:04 INFO - mozdevice == 0.47 06:24:04 INFO - mozfile == 1.2 06:24:04 INFO - mozhttpd == 0.7 06:24:04 INFO - mozinfo == 0.9 06:24:04 INFO - mozleak == 0.1 06:24:04 INFO - mozlog == 3.1 06:24:04 INFO - moznetwork == 0.27 06:24:04 INFO - mozprocess == 0.22 06:24:04 INFO - mozprofile == 0.27 06:24:04 INFO - mozrunner == 6.11 06:24:04 INFO - mozscreenshot == 0.1 06:24:04 INFO - mozsystemmonitor == 0.0 06:24:04 INFO - moztest == 0.7 06:24:04 INFO - mozversion == 1.4 06:24:04 INFO - psutil == 3.1.1 06:24:04 INFO - requests == 1.2.3 06:24:04 INFO - wsgiref == 0.1.2 06:24:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:24: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 06:24: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 06:24:04 INFO - Using env: {'DISPLAY': ':0', 06:24:04 INFO - 'HOME': '/home/cltbld', 06:24:04 INFO - 'LANG': 'en_US.UTF-8', 06:24:04 INFO - 'LANGUAGE': 'en_US:en', 06:24:04 INFO - 'LOGNAME': 'cltbld', 06:24:04 INFO - 'MAIL': '/var/mail/cltbld', 06:24:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:04 INFO - 'MOZ_NO_REMOTE': '1', 06:24:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:04 INFO - 'NO_EM_RESTART': '1', 06:24:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:04 INFO - 'PWD': '/builds/slave/test', 06:24:04 INFO - 'SHELL': '/bin/bash', 06:24:04 INFO - 'SHLVL': '1', 06:24:04 INFO - 'TERM': 'linux', 06:24:04 INFO - 'TMOUT': '86400', 06:24:04 INFO - 'USER': 'cltbld', 06:24:04 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:24:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:04 INFO - '_': '/tools/buildbot/bin/python'} 06:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24: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)) 06:24:05 INFO - Cleaning up... 06:24:05 INFO - Return code: 0 06:24:05 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 06:24: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')]} 06:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 06:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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')]} 06:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 06:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 06:24: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 0x25b0030>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x27128a0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x27e1210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, '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': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', '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 06:24: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 06:24: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 06:24:05 INFO - Using env: {'DISPLAY': ':0', 06:24:05 INFO - 'HOME': '/home/cltbld', 06:24:05 INFO - 'LANG': 'en_US.UTF-8', 06:24:05 INFO - 'LANGUAGE': 'en_US:en', 06:24:05 INFO - 'LOGNAME': 'cltbld', 06:24:05 INFO - 'MAIL': '/var/mail/cltbld', 06:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:05 INFO - 'MOZ_NO_REMOTE': '1', 06:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:05 INFO - 'NO_EM_RESTART': '1', 06:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:05 INFO - 'PWD': '/builds/slave/test', 06:24:05 INFO - 'SHELL': '/bin/bash', 06:24:05 INFO - 'SHLVL': '1', 06:24:05 INFO - 'TERM': 'linux', 06:24:05 INFO - 'TMOUT': '86400', 06:24:05 INFO - 'USER': 'cltbld', 06:24:05 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:05 INFO - '_': '/tools/buildbot/bin/python'} 06:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 06:24:05 INFO - Downloading/unpacking jsonschema 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24: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 06:24:06 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 06:24:06 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 06:24:06 INFO - Downloading/unpacking functools32 (from jsonschema) 06:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 06:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 06:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 06:24:07 INFO - Downloading functools32-3.2.3-2.tar.gz 06:24: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 06:24:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 06:24:07 INFO - warning: no files found matching '*.txt' 06:24:07 INFO - no previously-included directories found matching 'build' 06:24:07 INFO - no previously-included directories found matching 'dist' 06:24:07 INFO - no previously-included directories found matching '.git*' 06:24:07 INFO - Installing collected packages: jsonschema, functools32 06:24:07 INFO - Running setup.py install for functools32 06:24:07 INFO - warning: no files found matching '*.txt' 06:24:07 INFO - no previously-included directories found matching 'build' 06:24:07 INFO - no previously-included directories found matching 'dist' 06:24:07 INFO - no previously-included directories found matching '.git*' 06:24:07 INFO - Successfully installed jsonschema functools32 06:24:07 INFO - Cleaning up... 06:24:07 INFO - Return code: 0 06:24:07 INFO - Running post-action listener: _resource_record_post_action 06:24:07 INFO - Running post-action listener: _start_resource_monitoring 06:24:07 INFO - Starting resource monitoring. 06:24:07 INFO - ##### 06:24:07 INFO - ##### Running install step. 06:24:07 INFO - ##### 06:24:07 INFO - Running pre-action listener: _resource_record_pre_action 06:24:07 INFO - Running main action method: install 06:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 06:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 06:24:07 INFO - Reading from file tmpfile_stdout 06:24:07 INFO - Detecting whether we're running mozinstall >=1.0... 06:24:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 06:24:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 06:24:07 INFO - Reading from file tmpfile_stdout 06:24:07 INFO - Output received: 06:24:07 INFO - Usage: mozinstall [options] installer 06:24:07 INFO - Options: 06:24:07 INFO - -h, --help show this help message and exit 06:24:07 INFO - -d DEST, --destination=DEST 06:24:07 INFO - Directory to install application into. [default: 06:24:07 INFO - "/builds/slave/test"] 06:24:07 INFO - --app=APP Application being installed. [default: firefox] 06:24:07 INFO - mkdir: /builds/slave/test/build/application 06:24: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'] 06:24: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 06:24:22 INFO - Reading from file tmpfile_stdout 06:24:22 INFO - Output received: 06:24:22 INFO - /builds/slave/test/build/application/firefox/firefox 06:24:22 INFO - Running post-action listener: _resource_record_post_action 06:24:22 INFO - ##### 06:24:22 INFO - ##### Running run-tests step. 06:24:22 INFO - ##### 06:24:22 INFO - Running pre-action listener: _resource_record_pre_action 06:24:22 INFO - Running main action method: run_tests 06:24:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 06:24:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 06:24:22 INFO - Python 2.7.3 06:24:22 INFO - Return code: 0 06:24:22 INFO - grabbing minidump binary from tooltool 06:24: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')]} 06:24: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 0x2873220>, '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 0x27df2b0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x27df740>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 06:24: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 06:24: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 06:24:22 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 06:24:22 INFO - Return code: 0 06:24:22 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 06:24:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 06:24:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 06:24:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 06:24:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 06:24: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/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] in /builds/slave/test/build 06:24: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/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-047 --webServer localhost 06:24:22 INFO - Using env: {'DISPLAY': ':0', 06:24:22 INFO - 'HOME': '/home/cltbld', 06:24:22 INFO - 'LANG': 'en_US.UTF-8', 06:24:22 INFO - 'LANGUAGE': 'en_US:en', 06:24:22 INFO - 'LOGNAME': 'cltbld', 06:24:22 INFO - 'MAIL': '/var/mail/cltbld', 06:24:22 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 06:24:22 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 06:24:22 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 06:24:22 INFO - 'MOZ_NO_REMOTE': '1', 06:24:22 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 06:24:22 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 06:24:22 INFO - 'NO_EM_RESTART': '1', 06:24:22 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 06:24:22 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 06:24:22 INFO - 'PWD': '/builds/slave/test', 06:24:22 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 06:24:22 INFO - 'SHELL': '/bin/bash', 06:24:22 INFO - 'SHLVL': '1', 06:24:22 INFO - 'TERM': 'linux', 06:24:22 INFO - 'TMOUT': '86400', 06:24:22 INFO - 'USER': 'cltbld', 06:24:22 INFO - 'XDG_SESSION_COOKIE': 'f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706', 06:24:22 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 06:24:22 INFO - '_': '/tools/buildbot/bin/python'} 06:24: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/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-047', '--webServer', 'localhost'] with output_timeout 3600 06:24:22 INFO - mozversion INFO | application_buildid: 20151125050133 06:24:22 INFO - mozversion INFO | application_changeset: 75fc4684b2aac50fb8ea568c679529be710d46f4 06:24:22 INFO - mozversion INFO | application_display_name: Nightly 06:24:22 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 06:24:22 INFO - mozversion INFO | application_name: Firefox 06:24:22 INFO - mozversion INFO | application_remotingname: firefox 06:24:22 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 06:24:22 INFO - mozversion INFO | application_vendor: Mozilla 06:24:22 INFO - mozversion INFO | application_version: 45.0a1 06:24:22 INFO - mozversion INFO | platform_buildid: 20151125050133 06:24:22 INFO - mozversion INFO | platform_changeset: 75fc4684b2aac50fb8ea568c679529be710d46f4 06:24:22 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 06:24:22 INFO - mozversion INFO | platform_version: 45.0a1 06:24:22 INFO - 2015-11-25 06:24:22,628 DEBUG : using testdate: 1448461462 06:24:22 INFO - 2015-11-25 06:24:22,628 DEBUG : actual date: 1448461462 06:24:22 INFO - 2015-11-25 06:24:22,643 INFO : starting webserver on 'localhost:41938' 06:24:22 INFO - 2015-11-25 06:24:22,644 INFO : Starting test suite talos-linux64-ix-047 06:24:22 INFO - 2015-11-25 06:24:22,644 INFO : Starting test dromaeo_css 06:24:22 INFO - 2015-11-25 06:24:22,644 DEBUG : operating with platform_type : linux_ 06:24:22 INFO - 2015-11-25 06:24:22,644 INFO : Initialising browser for dromaeo_css test... 06:24:22 INFO - 2015-11-25 06:24:22,659 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqfil74/profile http://localhost:41938/getInfo.html 06:24:26 INFO - 2015-11-25 06:24:26,714 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:24:26 INFO - 2015-11-25 06:24:26,714 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:24:26 INFO - 2015-11-25 06:24:26,714 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:24:26 INFO - 2015-11-25 06:24:26,714 DEBUG : BROWSER_OUTPUT: __metrics 06:24:26 INFO - 2015-11-25 06:24:26,798 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] 06:24:28 INFO - 2015-11-25 06:24:28,128 INFO : Browser initialized. 06:24:28 INFO - 2015-11-25 06:24:28,129 INFO : Running cycle 1/1 for dromaeo_css test... 06:24:28 INFO - 2015-11-25 06:24:28,129 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqfil74/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:24:40 INFO - 2015-11-25 06:24:40,101 DEBUG : BROWSER_OUTPUT: RSS: Main: 139485184 06:24:40 INFO - 2015-11-25 06:24:40,102 DEBUG : BROWSER_OUTPUT: 06:25:31 INFO - 2015-11-25 06:25:31,170 DEBUG : BROWSER_OUTPUT: 1448461531170 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] 06:27:42 INFO - 2015-11-25 06:27:42,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41938/tests/dromaeo/cssquery-ext.html) 06:27:44 INFO - 2015-11-25 06:27:44,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 215298048 06:27:44 INFO - 2015-11-25 06:27:44,095 DEBUG : BROWSER_OUTPUT: 06:30:46 INFO - 2015-11-25 06:30:46,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-ext.html (next: http://localhost:41938/tests/dromaeo/cssquery-jquery.html) 06:30:47 INFO - 2015-11-25 06:30:47,158 DEBUG : BROWSER_OUTPUT: RSS: Main: 218791936 06:30:47 INFO - 2015-11-25 06:30:47,158 DEBUG : BROWSER_OUTPUT: 06:33:49 INFO - 2015-11-25 06:33:49,259 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41938/tests/dromaeo/cssquery-mootools.html) 06:33:49 INFO - 2015-11-25 06:33:49,827 DEBUG : BROWSER_OUTPUT: RSS: Main: 212148224 06:33:49 INFO - 2015-11-25 06:33:49,828 DEBUG : BROWSER_OUTPUT: 06:36:51 INFO - 2015-11-25 06:36:51,784 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41938/tests/dromaeo/cssquery-prototype.html) 06:36:52 INFO - 2015-11-25 06:36:52,366 DEBUG : BROWSER_OUTPUT: RSS: Main: 201433088 06:36:52 INFO - 2015-11-25 06:36:52,366 DEBUG : BROWSER_OUTPUT: 06:39:55 INFO - 2015-11-25 06:39:55,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41938/tests/dromaeo/cssquery-yui.html) 06:39:55 INFO - 2015-11-25 06:39:55,644 DEBUG : BROWSER_OUTPUT: RSS: Main: 205307904 06:39:55 INFO - 2015-11-25 06:39:55,644 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,222 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/dromaeo/cssquery-yui.html (next: http://localhost:41938/tests/dromaeo/cssquery-dojo.html) 06:42:58 INFO - 2015-11-25 06:42:58,467 DEBUG : BROWSER_OUTPUT: RSS: Main: 248242176 06:42:58 INFO - 2015-11-25 06:42:58,468 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,468 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:42:58 INFO - 2015-11-25 06:42:58,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:42:58 INFO - 2015-11-25 06:42:58,468 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:42:58 INFO - 2015-11-25 06:42:58,468 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:42:58 INFO - 2015-11-25 06:42:58,470 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2574.9098781542643;2638.762511373976;2640.8415495070285;2654.4027593791398;2662.1880326500414;4350.456192975878;4487.596116349528;4515.322701594762;4533.705309154902;4569.565891240331;4424.535423780505;4448.11037792442;4479.753613551254;4518.028623845872;4559.977200114003;4164.729292595986;4234.957650423503;4254.234237837188;4275.893102672427;4291.184674911772;4255.212785634652;4310.612044915973;4329.393884856123;4333.263345231302;4338.869833904988;4024.7182697211206;4128.195001974616;4174.352975288835;4267.274563324242;4291.50647675515;4188.350805625102;4192.350185721218;4202.558731333227;4206.3690446432975;4237.216115018731;4171.812268447927;4196.748195108273;4201.558836322203;4226.788660566959;4227.450431443924;4259.978700106511;4347.152305300468;4364.563543645641;4368.672349573794;4383.956160438387;4733.857984260478;4748.002919386933;4764.094821983812;4780.354652121989;4839.782209800567;4897.559219670246;4899.044686286175;4905.730184839832;4914.680545764514;4920.6309526785635;4533.048059907391;4537.115262523809;4539.614132798683;4547.818087276538;4579.313103034505;4742.620590352763;4856.854294371175;4991.276264941564;5029.974850125726;5037.647364684511;4659.370984916993;4713.622910167179;4719.5752382285755;4726.810927562928;4769.046190761792;4834.250691142878;4846.5153484651255;4851.126797176472;4852.2479015752615;4880.170371036932;4570.200214962369;4680.485146633868;4685.789139488663;4793.616510679138;4797.56821886032;4668.813247470063;4740.834070807505;4758.524147585283;4781.2350023996;4784.354112194878;4056.675465962716;4062.289099407592;4064.878053658395;4065.28857449951;4105.548389677133;3571.62497937718;3572.69632081276;3575.0883524701035;3594.67647911684;3601.603823579404;3989.222101690201;4087.3460246361033;4090.6113919178224;4171.290880550314;4289.356596510548;4892.437369702458;4907.288443175719;4910.607151427948;4910.631702622318;4956.058348913695;4206.831726730958;4215.388768628593;4217.219814334358;4221.620054195076;4262.50981137167;4036.8788936331957;4134.00783811883;4135.8966025848995;4138.8551400700835;4246.214450326699;4577.56513131252;4600.585947264763;4601.0567833594705;4605.631549476034;4625.537446255347;4839.516048395132;4844.442889067803;4846.636502262415;4849.127157111613;4894.045661096052;4370.978145109254;4471.955280447154;4476.9328460073775;4476.955230447784;4583.220852455024;4778.593819525379;4785.49752276006;4796.928046079382;4799.736014519235;4843.660943733905;4919.262110683426;4923.753812309298;4926.827561035347;4931.3835770528685;4977.4524802271;4493.730376177309;4599.770011499345;4601.585857272861;4608.147492713724;4709.693869898446;4718.7640617969655;4749.24012158053;4756.167670657552;4757.072370887644;4808.735519546459;4625.560571745679;4632.328312394617;4645.930311045405;4670.696404733681;4695.859124226278;4497.8200871964755;4603.700759450759;4614.561616646413;4632.2819962905805;4679.157751604744;4550.7952142154345;4557.4531056272135;4578.862047360036;4580.381648477412;4592.770361481979 06:42:58 INFO - 2015-11-25 06:42:58,473 DEBUG : BROWSER_OUTPUT: |1;ext.html;470.1889241059171;481.05232691597587;544.9046416877045;549.162527146102;557.9832605021851;21702.674459883096;22079.33761987141;33991.32017359651;34408.31183376331;34491.482627760604;40886.38670419939;41066.794666026704;41202.38196427056;41284.793576032156;41366;6492.772752953648;7989.960050199756;8148.796280092985;8163.755087347359;8168.387370947203;6578.177727784027;10105.494725263745;10377.533011014484;10379.740506487322;10381.636642717507;10063.044010818998;10189.796204075914;10191.643292484765;10192.490375481233;10196.439195844225;6641.203055633307;6799.932000679979;9628.374155679858;9702.757431064245;9916.851247231298;9948.502574871227;10086;10094.596216151345;10096.444695541742;10100.040496152928;36604.63395366039;36948.07629809249;37109.62890371089;37235.255294894225;37367.25265494675;2555.565553855849;2620.9868950655314;2651;2666.200139958005;2752.518309295865;28211.435771284665;28407.147785566467;28724.42551148965;28829;28957.276068098254;3476.461148521983;3508.1405055761247;3541.787492750443;3572.5712914450173;3695.334839728848;225461;225968;227386;228525;229477;31947.680523194937;55901.44098559044;56291.43708562944;56320.43679563234;56344.43655563392;31551.84224078865;65537;66737.33262667312;66794.66602666955;66885.33114668888;12484.563040293546;12736.23582585048;12739.681507962376;12754.872451275369;12765.042621803215;9331.813363732823;9422.575984080733;9429;9430.90569094314;9433.858492122623;15756.212189390484;15761.763573546406;15797.36810527589;15834.28745706446;15893.364265429253;7422.517536360119;7812.218778122256;7813.257740514642;7887.177591383412;7887.881681774778;747.114669117098;805.8106345008919;830.8919840420707;913.5158366065996;925.6528801699362;21807.563848722937;21885.452863678216;21979.560408791735;22041.779582204294;22093.226737064124;897.2463130970017;938.1837801113076;1039.8024375368657;1052.736815796051;1052.9947350263199;12373.061736008152;12384.195027323196;12435.191712538655;12489.875101248872;12509.937450312691;272468;277165;277258;277502;277632;45339.54660453419;45753.77123114363;45754.025988310656;45762;45859.77070114628;1174.988250117505;1187.5249900040053;1192.7375977284983;1195;1208.812634041725;23124;24383.14658986927;28485.287867803472;29878.70121298759;31079.223019424695;42548.78725606352;43661.12677746491;43667;43670.781646091564;43695.781521093464;228835;235907;253169;253707;255664;35737.82131089432;35839;35982.46026309555;36130;36451.350040743724;41353.58646413618;41477.792611036755;41508.1698366037;41919.580804191566;41955.7902210487;35233;35665.44292100618;35888.82055589705;36514.2614303923;37083.814580926926;33545.849967228394;33672.49491257682;34239.48640770341;34406.82796586001;34416.139596510286;34451.4832277511;35043.82478087695;35073.29853402969;35421.29157416786;35440.822795885855;30509.389812204077;31107.533386999665;31448.68551314549;31497.8425107873;31585.21036974094;22045.22841700597;22071.22750703782;22178.889105554368;22214;24881.751182488668 06:42:58 INFO - 2015-11-25 06:42:58,473 DEBUG : BROWSER_OUTPUT: |2;jquery.html;320.6969413903862;334.79242869420955;336.15121817411034;336.94777309517025;338.83227802237894;10938.234323597351;11260.887391126107;14984.475543355984;15426.305816238268;15715.44995925143;8966.462012279268;8999;9055.909440905589;9283.4429934204;9296.349255552097;3992.4809774729315;4651.930221046687;4652.74409907455;4655.348251244828;4663.323818046381;3232.2081090132833;3305.5041743738393;4572.702774319659;4975.477574854643;5093.26147708582;5060.443351231362;5088.618353623475;5089.592832573385;5104.8979020419565;5110.105731496992;4924.359833221676;5026.321446604698;5035.571976382012;5071.391433028023;5074.4671809460215;4902.289168070645;4906.533879281463;4907.730074845882;4910.9932463844825;4911.828086017008;11067.335959842436;15294.770578441221;17418;17701.114944252735;17703.468895933143;1798.9550261243444;1817.8636602254883;1820.8907465552109;1826.9086545672662;1840.1167439628919;8623.31013518917;8854.690085847029;8877.866831997526;8940.46357218569;12291.754164916652;1478.7633978563379;1584.6038490377405;1734.037609126934;1769.2745974150664;1777.7866656001233;53446.46553534493;56032;56531.71734141344;56709.14936275959;57196.714016430065;9494.572744226527;9700.126988571063;9717.076877696607;9790.657326993522;9851.704448866545;12464.875351246554;12469.563565275172;12477.251364918135;12479.313637749829;12484.937575312066;6443.162388889508;6473.417392434703;6565.277819439858;6565.606063636197;6645.335466453316;6006.099085137177;6023.849403764941;6074.7266373012435;6075.3924607539775;6084.726187321581;3924.3132451820816;3989.5212574491247;3996.5603783583783;4040.0909795295825;4057.797110144481;1422.4239183130849;1454.0766613200694;1454.6945141520187;1651.4302565614844;1662.709025920459;642.8135840606266;841.9536925469158;909.1817364372118;911.7310393433953;962.5572236771163;13091.345432728325;14725.337359818834;15007.699846003019;15683.529494115195;16242.593935151715;817.1379194949267;820.0610301205206;844.6410275632832;861.8664107063415;872.7425409504211;7834.6866125354345;8976.820463590822;9056.864147037799;9174.816503669888;9190.264778817678;323766;329465;506196;512160;513140;68522.65738671274;70015.64992175007;71460;71660.64169679118;73589.26410735931;432.85283003778864;441.5077188934315;940.2618944128826;964.9421034737938;967.6758285974278;9030.096990300917;9269.026752190923;9307.488088155216;9438.48088355147;9503.382280151767;31353.21616959503;33048.50427243641;33184.834075829465;34178;34414.82792586021;42412.36381454342;43613.345799813666;43869.561304386545;44276.77861610671;46092.30861537147;8760.912390876265;8781.331547006048;9000.279977601907;9008.189262966365;9039.412438191497;10435;15512.84487155114;16120.516384508484;16469.505914822574;16502.75245871337;9327.58025888823;9738.074882886114;11988.340641264465;12458.127931044739;12582.30797306157;12361.567345142877;12725;12859.678508037374;13007.154534955198;13073;9832.754181145528;12187.573434929735;12332.876671233173;12408.81386779217;12804.359782011048;6330.905036424365;8596.957015214884;8613.052564218056;8650.610722517376;8670.393072485118;8503.149685031447;9493;12660.11379203447;13234.470621175045;13255.204687718382 06:42:58 INFO - 2015-11-25 06:42:58,477 DEBUG : BROWSER_OUTPUT: |3;mootools.html;898.5103118800254;1313.6158665747269;1389.1387339849296;1392.6796836727553;1469.2286549561486;5239.187925871492;6649.135612370391;6753.290904455035;6761.526693131483;6761.763338283161;6628.270890202074;6715.865682686355;6743.730250789975;6768.357006084414;6786.321367863211;1683.9579010524712;1716.2877405876545;1988.7911769264235;2013.5368865161022;2055.784142665021;1975.150685205361;1975.5456245063644;1981.5739615982561;1981.9207231710714;1982.0585222019497;1973.2304401283438;1986.1161783006496;2015.193922431032;2036.511237303044;2038.4598081508339;1978.436145698469;1989.9602007959832;2007.1068374573322;2026;2026.2199053364486;2062.1442101527846;2080.355089922129;2084.030925619594;2085.4786303424144;2086.5096702274955;6587.5718078325235;6635.966820165917;6640.468762498988;6652.168478940132;6659.9001014984815;3774.301754175486;3800.6769424598942;3839.827207775657;3854.6338097880657;3866.284737323576;2143.582001509706;2545.6945166579944;2595.4160313929406;2627.38256509722;2629.789616830668;756.7200135949679;832.9541875196862;838.5890913452425;863.8617821148649;874.9212570868652;8755.124487551258;8802.383833131684;8802.64789408423;8817.382783205177;8824.249938755149;3605.5853576838476;3627.5828279748166;3634.545681789776;3667.1015601177883;3685.041889108851;7321.341079302888;7324.63376831167;7335.486515943832;7344.70621175147;7348.595827229554;3806;3806.410006449005;3811.2187001664593;3814.7520411173186;3824.1395685970433;3436.0207340907723;3473;3476.14834365577;3483.320752453247;3487.075924879909;3144.4182826176775;3147.291859331632;3191.9042428727175;3197.840107994591;3199.2161920329204;989.2827699917502;997.2819569909653;999.1906555689915;1006.6225165562914;1007.189212683782;750.6021808441535;875.7066382761847;877.0527829943645;891.5319457284847;891.8038031633031;5775.16260142277;5999.460048595647;6007.729652165663;6012.789552365646;6017.638941663514;921.6774129054911;926.420986883198;1012.6101450941441;1021.2187676427538;1032.1897310611134;4683.110209060335;4766.713997160182;4795.544423279783;4806.134895718804;4846.80612775492;6974.686139123752;7205.4595905307315;7986.201379862084;8179.754607361789;8273.669053237803;7761.805954851174;7788.065432148179;7825.647845846836;7903.762887113396;7909.050913890255;6140.785072522441;6256.405641464054;6309.3690630936535;6310.116583678288;6312.968435157794;5965.821025369072;6178.752849886134;6189.690515474118;6191.00943849;6198.163247961648;7251;7410.814729631802;7429.33136017761;7438.92561074404;7445.553266804009;7347.66935487915;7495.812604684708;7603.353714934293;7604.42966777505;7671.923280767344;5446.101393270224;5523.861903452445;5525.944740552543;5528.612997090326;5536.52939500147;6233.937660623517;6311.842203944938;6348.079528468438;6363.7772677956045;6368.203974503187;5806.042003069446;5844.561657875592;5888.352281248974;5906.497947674496;5998.280206375263;5832.679202643895;5837.066069428871;5902.734376952962;5951.523878089656;5971.940280597139;5783.074708046693;5790.073588225863;5800.9419905800405;5845.064789633639;5862.355140934579;5094.363204599425;5437.728113594384;5526.447355264441;5536.390996990247;5542.667439953616;5506.256655351636;5542.944570554243;5557.833265002057;5563.972180139235;5567.721613919369 06:42:58 INFO - 2015-11-25 06:42:58,478 DEBUG : BROWSER_OUTPUT: |4;prototype.html;289.9637545306837;294.74946295648704;299.2862024072587;299.77516862353247;305.90364035328884;5156.2265660151;5219.668984408975;5258.342707161605;5293.550048245904;5311.60162987776;5156.587473002161;5204.34945631796;5207.531322181003;5224.503672151149;5232.372115346155;4083.060895993923;4091.0999580092334;4091.304478238692;4092.0997380576373;4092.242935057009;4061.0862555924828;4085.3667681509264;4086.284900142478;4090.0797320602774;4095.7542547447247;3979.084810493588;4040.4545386372906;4062.939055914164;4065.9390109148385;4069.877903662895;4035.7174997750317;4049.088954985134;4051.270771261172;4063.6342729154517;4066.3087275163293;3568.553930758655;3572.4105522588743;3572.821358932069;3579.7494175407733;3588.372034893909;5058.595312375038;5059.62052846038;5063.291139240509;5065.4174769901565;5069.594432445396;4684.156851766681;4684.742339171345;4686.343911852344;4688.859334219979;4689.695169813986;5309.840704778863;5483.232347471358;5491.615586908918;5494.642848214853;5506.650870536744;3792.563855156665;3800.923981520382;3809.2381523695094;3812.1994381179984;3814.618538146191;5577.191307260465;5685.488306052475;5705.201271821907;5792.275965504312;5799.18811366409;3784.5647750509042;3829.272438236726;3840.462335273064;3856.807159642007;3872.1094148346037;3900.7854567999034;3905.0432644002403;3905.7851818150275;3905.882823515299;3908.413737939332;4301.07526881722;4391.231534481453;4502.954970450253;4505.977470112629;4586.2661974083985;5506.724663766876;5513.531349835309;5514.172874068921;5515.227868098469;5521.2270282160525;1387.61840493865;1401.0962928911;1402.712443948988;1402.9929850350886;1403.2422491854284;935.3172184305495;938.596403546468;949.2216382566368;963.6530848894392;966.7824739433712;4870.439899411542;4880;4880.95119048805;4887.902241955212;4887.975560122177;5697.971510142505;5728.51307638847;5736.627119237236;5740.885182296331;5741.081426971748;4865.099956508057;4869.975650121727;4870.050340183701;4871.634627402959;4874.439439464436;3009.864556094981;3054.266975925806;3060.9234769130503;3089.4130115278026;3092.9381412372077;5411.810586629449;5414.133738601805;5417.972910135424;5418.647787893774;5434.809781657623;5883.294004719461;5889.322727886348;5900.203472531153;5906;5908.05471124618;5428.5114339708825;5430.294061771944;5434;5436.266104075899;5439.5104440600535;5664.348599911063;5732.627379220337;5809.128630705428;5809.709514524172;5812.3025236971835;5623.831285061455;5647.040003199384;5648.378678345297;5653.604247702621;5662.688552129673;5480.068388374066;5488.4237155098135;5493.7802487900035;5502.174673798962;5503.9174412383045;3873.3608954522188;3927.5876033017266;3967.206558688332;3967.92064158721;3970.0273433009097;5518.255035570147;5695.117256825199;5785.942140578541;5790.26292112373;5796.42035796417;5457.20870473787;5555.944440555704;5586.916196257141;5588.804391846266;5589.916151257816;5555.694436806015;5566.582506311962;5570.3315602128005;5573.442655734394;5585.469380408855;5309.814156504503;5432.538234249975;5437.4562543745305;5440.700761458158;5450.836474905759;5608.747606357642;5611.372701916399;5618.101103823368;5628.887422251614;5629.859253518531;5479.972600136974;5480.643758155867;5481.985832620978;5485.396606373375;5488.890222195613 06:42:58 INFO - 2015-11-25 06:42:58,478 DEBUG : BROWSER_OUTPUT: |5;yui.html;693.6670398208856;695.7808290388527;747.1184002876605;756.2928661701308;764.9158592554815;10662.946685266572;10927.726806829824;11062.1703372247;11777.116716246295;11815.881841181586;11947.701307467318;11953.10351723622;11963.641090767269;11968.102392320567;11970.34163121028;350.556545969349;352.8923678278124;752.3003606645844;758.5562445969101;776.2974508070178;763.0995425398028;764.5107131435885;770.4067867741835;770.660909199953;770.9575973321465;805.8589746794316;812.8455593437228;813.0974618173823;813.5606772342928;813.9023317201944;361.84983231958705;364.83035388544323;792.0693185507006;803.3813963248266;805.3718099882043;587.0694948506622;590.3181824992098;591.6923199936052;592.3661682000261;593.486634061538;11542.249753765978;11695.7076073098;11705.53177872884;11711.765764684658;11716.589919352868;10368.274220804547;10736.409497477636;11233.887661123366;11613.419329033515;11814.350210738407;8624.913750862537;8803.955980220058;9016.819663606757;9152.4966126863;9545.90454095457;3230.370077834823;3353.6478669739813;3378.2230087079865;3379.7634165608415;3380.780249283813;40607.7969610153;40949.385759213634;40955.180896381906;40971.1805763883;41013;9330.729347384224;9453.669121580711;9704.70885873425;9833.557489912828;9850.704478865502;17005.91497042507;17023.14884255782;17028.659426811395;17084.316627335014;17515.036672983108;6540.37866402691;6569.474442044625;6615.073889655452;6760;6858.6570671466225;3464.8614055438006;3483.9303213936087;3546.0957455848593;3568.3398571264397;3570.6786389225094;2493.8379005364955;2533.784628306578;2535.4168541235617;2537;2537.061287323702;458.1478450082843;458.4521496811279;460.77422063188794;485.42234740658506;485.47326151126424;415.82743161587604;431.73016864459714;459.6254052946838;484.06333744205074;484.30018623089296;6992.965035174791;7059.399951004119;7187.38907192884;7238.239984801626;7240.493165478366;399.3111882003579;436.1821584529008;488.19447910947224;501.1980830670897;536.7048123532041;3311.3542859142717;3325;3354.7483938704695;3457.896263112111;3512.877049303313;50881.236781447566;51343.48656513462;51415;55155;55744;44407.55592444099;44544.10911781811;44562;44787.328190077176;44802.77598611986;40744.18511629751;40980.180396392505;41316.1736765263;41855.58144418517;41939.99999999939;7088.716451341888;7122.6438678066925;7141.53580017318;7269.7455589054125;7475.813104672209;31470.68529314769;31886.681133188373;32121.196970075936;32140;32431.189220268738;36091.458628120075;37506.62493375031;39638.405423918084;39856.402153968294;40130.197396051335;9313.627454901729;9593.088656577615;9620.470874101991;9651.227901767983;9693.563789629625;9658.75853103678;9694.127528522467;9871.851922221316;10048.09567138961;10632.096271816983;9595;9604.95197524036;9728.464934428392;9751.658691946031;9865.556049977624;9581.904180958101;9649.758756031155;9756.26827987918;9828.754281142743;9837.360571562825;7797.649105790139;9915.702528924145;10017.649382271586;10183.592656293666;10715.732106697084;7123.074000379917;7373.446991475768;7517.248275172439;7685.5004424712215;7763.92236077632;7381.963090184515;7771.572563508835;7791.4935529190425;7819.335356494534;7894.960525197337 06:42:58 INFO - 2015-11-25 06:42:58,478 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,961 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: __startTimestamp1448462578467__endTimestamp 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:42:58 INFO - 2015-11-25 06:42:58,479 DEBUG : BROWSER_OUTPUT: Number of tests: 6 06:42:58 INFO - 2015-11-25 06:42:58,480 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,480 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4460.73 Median:4570.20 stddev:451.85 (9.9%) stddev-sans-first:428.33 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: Values: 2574.9 2638.8 2640.8 2654.4 2662.2 4350.5 4487.6 4515.3 4533.7 4569.6 4424.5 4448.1 4479.8 4518.0 4560.0 4164.7 4235.0 4254.2 4275.9 4291.2 4255.2 4310.6 4329.4 4333.3 4338.9 4024.7 4128.2 4174.4 4267.3 4291.5 4188.4 4192.4 4202.6 4206.4 4237.2 4171.8 4196.7 4201.6 4226.8 4227.5 4260.0 4347.2 4364.6 4368.7 4384.0 4733.9 4748.0 4764.1 4780.4 4839.8 4897.6 4899.0 4905.7 4914.7 4920.6 4533.0 4537.1 4539.6 4547.8 4579.3 4742.6 4856.9 4991.3 5030.0 5037.6 4659.4 4713.6 4719.6 4726.8 4769.0 4834.3 4846.5 4851.1 4852.2 4880.2 4570.2 4680.5 4685.8 4793.6 4797.6 4668.8 4740.8 4758.5 4781.2 4784.4 4056.7 4062.3 4064.9 4065.3 4105.5 3571.6 3572.7 3575.1 3594.7 3601.6 3989.2 4087.3 4090.6 4171.3 4289.4 4892.4 4907.3 4910.6 4910.6 4956.1 4206.8 4215.4 4217.2 4221.6 4262.5 4036.9 4134.0 4135.9 4138.9 4246.2 4577.6 4600.6 4601.1 4605.6 4625.5 4839.5 4844.4 4846.6 4849.1 4894.0 4371.0 4472.0 4476.9 4477.0 4583.2 4778.6 4785.5 4796.9 4799.7 4843.7 4919.3 4923.8 4926.8 4931.4 4977.5 4493.7 4599.8 4601.6 4608.1 4709.7 4718.8 4749.2 4756.2 4757.1 4808.7 4625.6 4632.3 4645.9 4670.7 4695.9 4497.8 4603.7 4614.6 4632.3 4679.2 4550.8 4557.5 4578.9 4580.4 4592.8 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:41265.56 Median:34412.23 stddev:65379.35 (190.0%) stddev-sans-first:65491.00 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: Values: 470.2 481.1 544.9 549.2 558.0 21702.7 22079.3 33991.3 34408.3 34491.5 40886.4 41066.8 41202.4 41284.8 41366.0 6492.8 7990.0 8148.8 8163.8 8168.4 6578.2 10105.5 10377.5 10379.7 10381.6 10063.0 10189.8 10191.6 10192.5 10196.4 6641.2 6799.9 9628.4 9702.8 9916.9 9948.5 10086.0 10094.6 10096.4 10100.0 36604.6 36948.1 37109.6 37235.3 37367.3 2555.6 2621.0 2651.0 2666.2 2752.5 28211.4 28407.1 28724.4 28829.0 28957.3 3476.5 3508.1 3541.8 3572.6 3695.3 225461.0 225968.0 227386.0 228525.0 229477.0 31947.7 55901.4 56291.4 56320.4 56344.4 31551.8 65537.0 66737.3 66794.7 66885.3 12484.6 12736.2 12739.7 12754.9 12765.0 9331.8 9422.6 9429.0 9430.9 9433.9 15756.2 15761.8 15797.4 15834.3 15893.4 7422.5 7812.2 7813.3 7887.2 7887.9 747.1 805.8 830.9 913.5 925.7 21807.6 21885.5 21979.6 22041.8 22093.2 897.2 938.2 1039.8 1052.7 1053.0 12373.1 12384.2 12435.2 12489.9 12509.9 272468.0 277165.0 277258.0 277502.0 277632.0 45339.5 45753.8 45754.0 45762.0 45859.8 1175.0 1187.5 1192.7 1195.0 1208.8 23124.0 24383.1 28485.3 29878.7 31079.2 42548.8 43661.1 43667.0 43670.8 43695.8 228835.0 235907.0 253169.0 253707.0 255664.0 35737.8 35839.0 35982.5 36130.0 36451.4 41353.6 41477.8 41508.2 41919.6 41955.8 35233.0 35665.4 35888.8 36514.3 37083.8 33545.8 33672.5 34239.5 34406.8 34416.1 34451.5 35043.8 35073.3 35421.3 35440.8 30509.4 31107.5 31448.7 31497.8 31585.2 22045.2 22071.2 22178.9 22214.0 24881.8 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,481 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:24231.68 Median:4909.36 stddev:73152.02 (1490.1%) stddev-sans-first:73335.20 06:42:58 INFO - 2015-11-25 06:42:58,482 DEBUG : BROWSER_OUTPUT: Values: 320.7 334.8 336.2 336.9 338.8 10938.2 11260.9 14984.5 15426.3 15715.4 8966.5 8999.0 9055.9 9283.4 9296.3 3992.5 4651.9 4652.7 4655.3 4663.3 3232.2 3305.5 4572.7 4975.5 5093.3 5060.4 5088.6 5089.6 5104.9 5110.1 4924.4 5026.3 5035.6 5071.4 5074.5 4902.3 4906.5 4907.7 4911.0 4911.8 11067.3 15294.8 17418.0 17701.1 17703.5 1799.0 1817.9 1820.9 1826.9 1840.1 8623.3 8854.7 8877.9 8940.5 12291.8 1478.8 1584.6 1734.0 1769.3 1777.8 53446.5 56032.0 56531.7 56709.1 57196.7 9494.6 9700.1 9717.1 9790.7 9851.7 12464.9 12469.6 12477.3 12479.3 12484.9 6443.2 6473.4 6565.3 6565.6 6645.3 6006.1 6023.8 6074.7 6075.4 6084.7 3924.3 3989.5 3996.6 4040.1 4057.8 1422.4 1454.1 1454.7 1651.4 1662.7 642.8 842.0 909.2 911.7 962.6 13091.3 14725.3 15007.7 15683.5 16242.6 817.1 820.1 844.6 861.9 872.7 7834.7 8976.8 9056.9 9174.8 9190.3 323766.0 329465.0 506196.0 512160.0 513140.0 68522.7 70015.6 71460.0 71660.6 73589.3 432.9 441.5 940.3 964.9 967.7 9030.1 9269.0 9307.5 9438.5 9503.4 31353.2 33048.5 33184.8 34178.0 34414.8 42412.4 43613.3 43869.6 44276.8 46092.3 8760.9 8781.3 9000.3 9008.2 9039.4 10435.0 15512.8 16120.5 16469.5 16502.8 9327.6 9738.1 11988.3 12458.1 12582.3 12361.6 12725.0 12859.7 13007.2 13073.0 9832.8 12187.6 12332.9 12408.8 12804.4 6330.9 8597.0 8613.1 8650.6 8670.4 8503.1 9493.0 12660.1 13234.5 13255.2 06:42:58 INFO - 2015-11-25 06:42:58,482 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,482 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4593.74 Median:5834.87 stddev:2369.34 (40.6%) stddev-sans-first:2359.70 06:42:58 INFO - 2015-11-25 06:42:58,483 DEBUG : BROWSER_OUTPUT: Values: 898.5 1313.6 1389.1 1392.7 1469.2 5239.2 6649.1 6753.3 6761.5 6761.8 6628.3 6715.9 6743.7 6768.4 6786.3 1684.0 1716.3 1988.8 2013.5 2055.8 1975.2 1975.5 1981.6 1981.9 1982.1 1973.2 1986.1 2015.2 2036.5 2038.5 1978.4 1990.0 2007.1 2026.0 2026.2 2062.1 2080.4 2084.0 2085.5 2086.5 6587.6 6636.0 6640.5 6652.2 6659.9 3774.3 3800.7 3839.8 3854.6 3866.3 2143.6 2545.7 2595.4 2627.4 2629.8 756.7 833.0 838.6 863.9 874.9 8755.1 8802.4 8802.6 8817.4 8824.2 3605.6 3627.6 3634.5 3667.1 3685.0 7321.3 7324.6 7335.5 7344.7 7348.6 3806.0 3806.4 3811.2 3814.8 3824.1 3436.0 3473.0 3476.1 3483.3 3487.1 3144.4 3147.3 3191.9 3197.8 3199.2 989.3 997.3 999.2 1006.6 1007.2 750.6 875.7 877.1 891.5 891.8 5775.2 5999.5 6007.7 6012.8 6017.6 921.7 926.4 1012.6 1021.2 1032.2 4683.1 4766.7 4795.5 4806.1 4846.8 6974.7 7205.5 7986.2 8179.8 8273.7 7761.8 7788.1 7825.6 7903.8 7909.1 6140.8 6256.4 6309.4 6310.1 6313.0 5965.8 6178.8 6189.7 6191.0 6198.2 7251.0 7410.8 7429.3 7438.9 7445.6 7347.7 7495.8 7603.4 7604.4 7671.9 5446.1 5523.9 5525.9 5528.6 5536.5 6233.9 6311.8 6348.1 6363.8 6368.2 5806.0 5844.6 5888.4 5906.5 5998.3 5832.7 5837.1 5902.7 5951.5 5971.9 5783.1 5790.1 5800.9 5845.1 5862.4 5094.4 5437.7 5526.4 5536.4 5542.7 5506.3 5542.9 5557.8 5564.0 5567.7 06:42:58 INFO - 2015-11-25 06:42:58,484 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,484 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4580.20 Median:5228.44 stddev:1357.14 (26.0%) stddev-sans-first:1322.19 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: Values: 290.0 294.7 299.3 299.8 305.9 5156.2 5219.7 5258.3 5293.6 5311.6 5156.6 5204.3 5207.5 5224.5 5232.4 4083.1 4091.1 4091.3 4092.1 4092.2 4061.1 4085.4 4086.3 4090.1 4095.8 3979.1 4040.5 4062.9 4065.9 4069.9 4035.7 4049.1 4051.3 4063.6 4066.3 3568.6 3572.4 3572.8 3579.7 3588.4 5058.6 5059.6 5063.3 5065.4 5069.6 4684.2 4684.7 4686.3 4688.9 4689.7 5309.8 5483.2 5491.6 5494.6 5506.7 3792.6 3800.9 3809.2 3812.2 3814.6 5577.2 5685.5 5705.2 5792.3 5799.2 3784.6 3829.3 3840.5 3856.8 3872.1 3900.8 3905.0 3905.8 3905.9 3908.4 4301.1 4391.2 4503.0 4506.0 4586.3 5506.7 5513.5 5514.2 5515.2 5521.2 1387.6 1401.1 1402.7 1403.0 1403.2 935.3 938.6 949.2 963.7 966.8 4870.4 4880.0 4881.0 4887.9 4888.0 5698.0 5728.5 5736.6 5740.9 5741.1 4865.1 4870.0 4870.1 4871.6 4874.4 3009.9 3054.3 3060.9 3089.4 3092.9 5411.8 5414.1 5418.0 5418.6 5434.8 5883.3 5889.3 5900.2 5906.0 5908.1 5428.5 5430.3 5434.0 5436.3 5439.5 5664.3 5732.6 5809.1 5809.7 5812.3 5623.8 5647.0 5648.4 5653.6 5662.7 5480.1 5488.4 5493.8 5502.2 5503.9 3873.4 3927.6 3967.2 3967.9 3970.0 5518.3 5695.1 5785.9 5790.3 5796.4 5457.2 5555.9 5586.9 5588.8 5589.9 5555.7 5566.6 5570.3 5573.4 5585.5 5309.8 5432.5 5437.5 5440.7 5450.8 5608.7 5611.4 5618.1 5628.9 5629.9 5480.0 5480.6 5482.0 5485.4 5488.9 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12099.28 Median:486.83 stddev:14194.43 (2915.7%) stddev-sans-first:14208.40 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: Values: 693.7 695.8 747.1 756.3 764.9 10662.9 10927.7 11062.2 11777.1 11815.9 11947.7 11953.1 11963.6 11968.1 11970.3 350.6 352.9 752.3 758.6 776.3 763.1 764.5 770.4 770.7 771.0 805.9 812.8 813.1 813.6 813.9 361.8 364.8 792.1 803.4 805.4 587.1 590.3 591.7 592.4 593.5 11542.2 11695.7 11705.5 11711.8 11716.6 10368.3 10736.4 11233.9 11613.4 11814.4 8624.9 8804.0 9016.8 9152.5 9545.9 3230.4 3353.6 3378.2 3379.8 3380.8 40607.8 40949.4 40955.2 40971.2 41013.0 9330.7 9453.7 9704.7 9833.6 9850.7 17005.9 17023.1 17028.7 17084.3 17515.0 6540.4 6569.5 6615.1 6760.0 6858.7 3464.9 3483.9 3546.1 3568.3 3570.7 2493.8 2533.8 2535.4 2537.0 2537.1 458.1 458.5 460.8 485.4 485.5 415.8 431.7 459.6 484.1 484.3 6993.0 7059.4 7187.4 7238.2 7240.5 399.3 436.2 488.2 501.2 536.7 3311.4 3325.0 3354.7 3457.9 3512.9 50881.2 51343.5 51415.0 55155.0 55744.0 44407.6 44544.1 44562.0 44787.3 44802.8 40744.2 40980.2 41316.2 41855.6 41940.0 7088.7 7122.6 7141.5 7269.7 7475.8 31470.7 31886.7 32121.2 32140.0 32431.2 36091.5 37506.6 39638.4 39856.4 40130.2 9313.6 9593.1 9620.5 9651.2 9693.6 9658.8 9694.1 9871.9 10048.1 10632.1 9595.0 9605.0 9728.5 9751.7 9865.6 9581.9 9649.8 9756.3 9828.8 9837.4 7797.6 9915.7 10017.6 10183.6 10715.7 7123.1 7373.4 7517.2 7685.5 7763.9 7382.0 7771.6 7791.5 7819.3 7895.0 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:42:58 INFO - 2015-11-25 06:42:58,485 DEBUG : BROWSER_OUTPUT: 06:42:59 INFO - 2015-11-25 06:42:59,246 INFO : Browser exited with error code: 0 06:42:59 INFO - 2015-11-25 06:42:59,264 INFO : Completed test dromaeo_css (00:18:36) 06:42:59 INFO - 2015-11-25 06:42:59,264 INFO : Starting test kraken 06:42:59 INFO - 2015-11-25 06:42:59,264 DEBUG : operating with platform_type : linux_ 06:42:59 INFO - 2015-11-25 06:42:59,264 INFO : Initialising browser for kraken test... 06:42:59 INFO - 2015-11-25 06:42:59,270 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBiwTv/profile http://localhost:41938/getInfo.html 06:43:03 INFO - 2015-11-25 06:43:03,146 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:43:03 INFO - 2015-11-25 06:43:03,147 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:43:03 INFO - 2015-11-25 06:43:03,147 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:43:03 INFO - 2015-11-25 06:43:03,147 DEBUG : BROWSER_OUTPUT: __metrics 06:43:03 INFO - 2015-11-25 06:43:03,235 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] 06:43:04 INFO - 2015-11-25 06:43:04,540 INFO : Browser initialized. 06:43:04 INFO - 2015-11-25 06:43:04,540 INFO : Running cycle 1/1 for kraken test... 06:43:04 INFO - 2015-11-25 06:43:04,540 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpHBiwTv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:43:16 INFO - 2015-11-25 06:43:16,321 DEBUG : BROWSER_OUTPUT: RSS: Main: 138780672 06:43:16 INFO - 2015-11-25 06:43:16,322 DEBUG : BROWSER_OUTPUT: 06:43:18 INFO - 2015-11-25 06:43:18,937 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41938/tests/kraken/driver.html?testName=audio-beat-detection) 06:43:19 INFO - 2015-11-25 06:43:19,519 DEBUG : BROWSER_OUTPUT: RSS: Main: 178302976 06:43:19 INFO - 2015-11-25 06:43:19,519 DEBUG : BROWSER_OUTPUT: 06:43:22 INFO - 2015-11-25 06:43:22,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41938/tests/kraken/driver.html?testName=audio-dft) 06:43:22 INFO - 2015-11-25 06:43:22,804 DEBUG : BROWSER_OUTPUT: RSS: Main: 167063552 06:43:22 INFO - 2015-11-25 06:43:22,804 DEBUG : BROWSER_OUTPUT: 06:43:25 INFO - 2015-11-25 06:43:25,825 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41938/tests/kraken/driver.html?testName=audio-fft) 06:43:26 INFO - 2015-11-25 06:43:26,386 DEBUG : BROWSER_OUTPUT: RSS: Main: 150761472 06:43:26 INFO - 2015-11-25 06:43:26,386 DEBUG : BROWSER_OUTPUT: 06:43:28 INFO - 2015-11-25 06:43:28,444 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41938/tests/kraken/driver.html?testName=audio-oscillator) 06:43:29 INFO - 2015-11-25 06:43:29,017 DEBUG : BROWSER_OUTPUT: RSS: Main: 153399296 06:43:29 INFO - 2015-11-25 06:43:29,018 DEBUG : BROWSER_OUTPUT: 06:43:31 INFO - 2015-11-25 06:43:31,291 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41938/tests/kraken/driver.html?testName=imaging-gaussian-blur) 06:43:31 INFO - 2015-11-25 06:43:31,852 DEBUG : BROWSER_OUTPUT: RSS: Main: 155230208 06:43:31 INFO - 2015-11-25 06:43:31,852 DEBUG : BROWSER_OUTPUT: 06:43:34 INFO - 2015-11-25 06:43:34,818 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41938/tests/kraken/driver.html?testName=imaging-darkroom) 06:43:35 INFO - 2015-11-25 06:43:35,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 156000256 06:43:35 INFO - 2015-11-25 06:43:35,399 DEBUG : BROWSER_OUTPUT: 06:43:38 INFO - 2015-11-25 06:43:38,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41938/tests/kraken/driver.html?testName=imaging-desaturate) 06:43:39 INFO - 2015-11-25 06:43:39,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 154652672 06:43:39 INFO - 2015-11-25 06:43:39,394 DEBUG : BROWSER_OUTPUT: 06:43:42 INFO - 2015-11-25 06:43:42,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41938/tests/kraken/driver.html?testName=json-parse-financial) 06:43:42 INFO - 2015-11-25 06:43:42,799 DEBUG : BROWSER_OUTPUT: RSS: Main: 154914816 06:43:42 INFO - 2015-11-25 06:43:42,799 DEBUG : BROWSER_OUTPUT: 06:43:44 INFO - 2015-11-25 06:43:44,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41938/tests/kraken/driver.html?testName=json-stringify-tinderbox) 06:43:45 INFO - 2015-11-25 06:43:45,139 DEBUG : BROWSER_OUTPUT: RSS: Main: 166748160 06:43:45 INFO - 2015-11-25 06:43:45,139 DEBUG : BROWSER_OUTPUT: 06:43:47 INFO - 2015-11-25 06:43:47,042 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-aes) 06:43:47 INFO - 2015-11-25 06:43:47,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 166703104 06:43:47 INFO - 2015-11-25 06:43:47,649 DEBUG : BROWSER_OUTPUT: 06:43:49 INFO - 2015-11-25 06:43:49,755 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-ccm) 06:43:50 INFO - 2015-11-25 06:43:50,336 DEBUG : BROWSER_OUTPUT: RSS: Main: 175898624 06:43:50 INFO - 2015-11-25 06:43:50,336 DEBUG : BROWSER_OUTPUT: 06:43:52 INFO - 2015-11-25 06:43:52,857 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 06:43:53 INFO - 2015-11-25 06:43:53,442 DEBUG : BROWSER_OUTPUT: RSS: Main: 181612544 06:43:53 INFO - 2015-11-25 06:43:53,443 DEBUG : BROWSER_OUTPUT: 06:43:56 INFO - 2015-11-25 06:43:56,030 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 06:43:56 INFO - 2015-11-25 06:43:56,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 179605504 06:43:56 INFO - 2015-11-25 06:43:56,611 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41938/tests/kraken/driver.html?testName=ai-astar) 06:43:58 INFO - 2015-11-25 06:43:58,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 237273088 06:43:58 INFO - 2015-11-25 06:43:58,611 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,611 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:43:58 INFO - 2015-11-25 06:43:58,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:43:58 INFO - 2015-11-25 06:43:58,612 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:43:58 INFO - 2015-11-25 06:43:58,612 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:43:58 INFO - 2015-11-25 06:43:58,612 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;113;106;112;113;112;102;118;115;105 06:43:58 INFO - 2015-11-25 06:43:58,613 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;157;137;156;171;131;160;152;134;168;130 06:43:58 INFO - 2015-11-25 06:43:58,613 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;162;162;161;163;163;162 06:43:58 INFO - 2015-11-25 06:43:58,613 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;71;88;91;72;72;72;92;88;71 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;94;139;94;95;94;130;94;94;125 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;110;110;110;110;109;109;110 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;147;146;147;147;147;146;146;146 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;94;95;95;95;95;95;95 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;72;71;71;73;72;72;72;71;73;71 06:43:58 INFO - 2015-11-25 06:43:58,614 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;69;69;68;69;69;69;68;77;70 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;84;82;84;84;83;85;83;84;83;84 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;120;118;126;125;117;128;120;126;128 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;146;137;149;139;147;148;150;147;145;140 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;68;69;68;70;70;71;70;70;68 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:43:58 INFO - 2015-11-25 06:43:58,615 DEBUG : BROWSER_OUTPUT: __start_cc_report 06:43:58 INFO - 2015-11-25 06:43:58,616 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 06:43:58 INFO - 2015-11-25 06:43:58,616 DEBUG : BROWSER_OUTPUT: __end_cc_report 06:43:58 INFO - 2015-11-25 06:43:58,616 DEBUG : BROWSER_OUTPUT: __startTimestamp1448462638610__endTimestamp 06:43:58 INFO - 2015-11-25 06:43:58,616 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: Number of tests: 14 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.80 Median:112.50 stddev:4.92 (4.4%) stddev-sans-first:5.20 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: Values: 112.0 113.0 106.0 112.0 113.0 112.0 102.0 118.0 115.0 105.0 06:43:58 INFO - 2015-11-25 06:43:58,620 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.60 Median:156.50 stddev:15.41 (9.8%) stddev-sans-first:16.12 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: Values: 157.0 137.0 156.0 171.0 131.0 160.0 152.0 134.0 168.0 130.0 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.80 Median:162.00 stddev:0.79 (0.5%) stddev-sans-first:0.78 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 162.0 162.0 161.0 163.0 163.0 162.0 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:80.00 stddev:9.42 (11.8%) stddev-sans-first:9.66 06:43:58 INFO - 2015-11-25 06:43:58,621 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 88.0 91.0 72.0 72.0 72.0 92.0 88.0 71.0 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.40 Median:94.00 stddev:18.21 (19.4%) stddev-sans-first:18.92 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: Values: 95.0 94.0 139.0 94.0 95.0 94.0 130.0 94.0 94.0 125.0 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.70 Median:110.00 stddev:0.48 (0.4%) stddev-sans-first:0.44 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.40 Median:146.50 stddev:0.52 (0.4%) stddev-sans-first:0.53 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 147.0 146.0 147.0 147.0 147.0 146.0 146.0 146.0 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,622 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:94.90 Median:95.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 94.0 95.0 95.0 95.0 95.0 95.0 95.0 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:71.80 Median:72.00 stddev:0.79 (1.1%) stddev-sans-first:0.83 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: Values: 72.0 71.0 71.0 73.0 72.0 72.0 72.0 71.0 73.0 71.0 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.70 Median:69.00 stddev:2.63 (3.8%) stddev-sans-first:2.77 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 69.0 68.0 69.0 69.0 69.0 68.0 77.0 70.0 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:84.00 stddev:0.84 (1.0%) stddev-sans-first:0.88 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: Values: 84.0 82.0 84.0 84.0 83.0 85.0 83.0 84.0 83.0 84.0 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,623 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:126.00 stddev:4.38 (3.5%) stddev-sans-first:4.34 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: Values: 128.0 120.0 118.0 126.0 125.0 117.0 128.0 120.0 126.0 128.0 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:144.80 Median:147.00 stddev:4.52 (3.1%) stddev-sans-first:4.77 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: Values: 146.0 137.0 149.0 139.0 147.0 148.0 150.0 147.0 145.0 140.0 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.50 Median:70.00 stddev:1.18 (1.7%) stddev-sans-first:1.12 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: Values: 71.0 68.0 69.0 68.0 70.0 70.0 71.0 70.0 70.0 68.0 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:43:58 INFO - 2015-11-25 06:43:58,624 DEBUG : BROWSER_OUTPUT: 06:43:59 INFO - 2015-11-25 06:43:59,522 INFO : Browser exited with error code: 0 06:43:59 INFO - 2015-11-25 06:43:59,576 INFO : Completed test kraken (00:01:00) 06:43:59 INFO - 2015-11-25 06:43:59,576 INFO : Starting test v8_7 06:43:59 INFO - 2015-11-25 06:43:59,576 DEBUG : operating with platform_type : linux_ 06:43:59 INFO - 2015-11-25 06:43:59,576 INFO : Initialising browser for v8_7 test... 06:43:59 INFO - 2015-11-25 06:43:59,582 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAQ7cET/profile http://localhost:41938/getInfo.html 06:44:03 INFO - 2015-11-25 06:44:03,339 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 06:44:03 INFO - 2015-11-25 06:44:03,339 DEBUG : BROWSER_OUTPUT: colorDepth:24 06:44:03 INFO - 2015-11-25 06:44:03,339 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 06:44:03 INFO - 2015-11-25 06:44:03,339 DEBUG : BROWSER_OUTPUT: __metrics 06:44:03 INFO - 2015-11-25 06:44:03,440 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] 06:44:04 INFO - 2015-11-25 06:44:04,801 INFO : Browser initialized. 06:44:04 INFO - 2015-11-25 06:44:04,802 INFO : Running cycle 1/1 for v8_7 test... 06:44:04 INFO - 2015-11-25 06:44:04,802 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpAQ7cET/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 06:44:16 INFO - 2015-11-25 06:44:16,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 141234176 06:44:16 INFO - 2015-11-25 06:44:16,761 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,211 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41938/tests/v8_7/run.html (next: http://localhost:41938/tests/v8_7/run.html) 06:44:38 INFO - 2015-11-25 06:44:38,461 DEBUG : BROWSER_OUTPUT: RSS: Main: 462958592 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: __start_tp_report 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 06:44:38 INFO - 2015-11-25 06:44:38,462 DEBUG : BROWSER_OUTPUT: |0;Richards;164.58196181698486 06:44:38 INFO - 2015-11-25 06:44:38,463 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;194.47685725398676 06:44:38 INFO - 2015-11-25 06:44:38,464 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.04557033682426 06:44:38 INFO - 2015-11-25 06:44:38,464 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5128.205128205128 06:44:38 INFO - 2015-11-25 06:44:38,464 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1988.0715705765408 06:44:38 INFO - 2015-11-25 06:44:38,464 DEBUG : BROWSER_OUTPUT: |5;Earley;792.5574030087095 06:44:38 INFO - 2015-11-25 06:44:38,465 DEBUG : BROWSER_OUTPUT: |6;Boyer;12390.243902439024 06:44:38 INFO - 2015-11-25 06:44:38,465 DEBUG : BROWSER_OUTPUT: |7;RegExp;26552.63157894737 06:44:38 INFO - 2015-11-25 06:44:38,465 DEBUG : BROWSER_OUTPUT: |8;Splay;650.1950585175553 06:44:38 INFO - 2015-11-25 06:44:38,465 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 06:44:38 INFO - 2015-11-25 06:44:38,465 DEBUG : BROWSER_OUTPUT: __end_tp_report 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: __startTimestamp1448462678461__endTimestamp 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: Number of tests: 10 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,466 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:164.58 Median:164.58 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,467 DEBUG : BROWSER_OUTPUT: Values: 164.6 06:44:38 INFO - 2015-11-25 06:44:38,467 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,467 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:194.48 Median:194.48 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,467 DEBUG : BROWSER_OUTPUT: Values: 194.5 06:44:38 INFO - 2015-11-25 06:44:38,467 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.05 Median:283.05 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: Values: 283.0 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5128.21 Median:5128.21 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: Values: 5128.2 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1988.07 Median:1988.07 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,468 DEBUG : BROWSER_OUTPUT: Values: 1988.1 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:792.56 Median:792.56 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: Values: 792.6 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12390.24 Median:12390.24 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: Values: 12390.2 06:44:38 INFO - 2015-11-25 06:44:38,469 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26552.63 Median:26552.63 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: Values: 26552.6 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:650.20 Median:650.20 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: Values: 650.2 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 06:44:38 INFO - 2015-11-25 06:44:38,470 DEBUG : BROWSER_OUTPUT: Values: 4835.7 06:44:38 INFO - 2015-11-25 06:44:38,471 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 06:44:38 INFO - 2015-11-25 06:44:38,471 DEBUG : BROWSER_OUTPUT: 06:44:39 INFO - 2015-11-25 06:44:39,325 INFO : Browser exited with error code: 0 06:44:39 INFO - 2015-11-25 06:44:39,342 INFO : Completed test v8_7 (00:00:39) 06:44:39 INFO - 2015-11-25 06:44:39,434 INFO : Completed test suite (00:20:16) 06:44:39 INFO - 2015-11-25 06:44:39,435 DEBUG : Working with test: dromaeo_css 06:44:39 INFO - 2015-11-25 06:44:39,435 DEBUG : Generating results file: dromaeo_css 06:44:39 INFO - 2015-11-25 06:44:39,436 DEBUG : Working with test: kraken 06:44:39 INFO - 2015-11-25 06:44:39,436 DEBUG : Generating results file: kraken 06:44:39 INFO - 2015-11-25 06:44:39,436 INFO : javascript benchmark 06:44:39 INFO - 2015-11-25 06:44:39,436 DEBUG : Working with test: v8_7 06:44:39 INFO - 2015-11-25 06:44:39,436 DEBUG : Generating results file: v8_7 06:44:39 INFO - 2015-11-25 06:44:39,437 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:44:39 INFO - 2015-11-25 06:44:39,517 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 06:44:39 INFO - 2015-11-25 06:44:39,517 DEBUG : process_Request line: dromaeo_css 6035.99 graph.html#tests=[[72,203,35]] 06:44:39 INFO - 2015-11-25 06:44:39,517 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:44:39 INFO - 2015-11-25 06:44:39,608 DEBUG : process_Request line: kraken 1520.50 graph.html#tests=[[232,203,35]] 06:44:39 INFO - 2015-11-25 06:44:39,608 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 06:44:39 INFO - 2015-11-25 06:44:39,662 DEBUG : process_Request line: v8_7 19565.92 graph.html#tests=[[230,203,35]] 06:44:39 INFO - 2015-11-25 06:44:39,663 INFO : javascript benchmark 06:44:39 INFO - 2015-11-25 06:44:39,667 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2574.9098781542643, 2638.762511373976, 2640.8415495070285, 2654.4027593791398, 2662.1880326500414, 4350.456192975878, 4487.596116349528, 4515.322701594762, 4533.705309154902, 4569.565891240331, 4424.535423780505, 4448.11037792442, 4479.753613551254, 4518.028623845872, 4559.977200114003, 4164.729292595986, 4234.957650423503, 4254.234237837188, 4275.893102672427, 4291.184674911772, 4255.212785634652, 4310.612044915973, 4329.393884856123, 4333.263345231302, 4338.869833904988, 4024.7182697211206, 4128.195001974616, 4174.352975288835, 4267.274563324242, 4291.50647675515, 4188.350805625102, 4192.350185721218, 4202.558731333227, 4206.3690446432975, 4237.216115018731, 4171.812268447927, 4196.748195108273, 4201.558836322203, 4226.788660566959, 4227.450431443924, 4259.978700106511, 4347.152305300468, 4364.563543645641, 4368.672349573794, 4383.956160438387, 4733.857984260478, 4748.002919386933, 4764.094821983812, 4780.354652121989, 4839.782209800567, 4897.559219670246, 4899.044686286175, 4905.730184839832, 4914.680545764514, 4920.6309526785635, 4533.048059907391, 4537.115262523809, 4539.614132798683, 4547.818087276538, 4579.313103034505, 4742.620590352763, 4856.854294371175, 4991.276264941564, 5029.974850125726, 5037.647364684511, 4659.370984916993, 4713.622910167179, 4719.5752382285755, 4726.810927562928, 4769.046190761792, 4834.250691142878, 4846.5153484651255, 4851.126797176472, 4852.2479015752615, 4880.170371036932, 4570.200214962369, 4680.485146633868, 4685.789139488663, 4793.616510679138, 4797.56821886032, 4668.813247470063, 4740.834070807505, 4758.524147585283, 4781.2350023996, 4784.354112194878, 4056.675465962716, 4062.289099407592, 4064.878053658395, 4065.28857449951, 4105.548389677133, 3571.62497937718, 3572.69632081276, 3575.0883524701035, 3594.67647911684, 3601.603823579404, 3989.222101690201, 4087.3460246361033, 4090.6113919178224, 4171.290880550314, 4289.356596510548, 4892.437369702458, 4907.288443175719, 4910.607151427948, 4910.631702622318, 4956.058348913695, 4206.831726730958, 4215.388768628593, 4217.219814334358, 4221.620054195076, 4262.50981137167, 4036.8788936331957, 4134.00783811883, 4135.8966025848995, 4138.8551400700835, 4246.214450326699, 4577.56513131252, 4600.585947264763, 4601.0567833594705, 4605.631549476034, 4625.537446255347, 4839.516048395132, 4844.442889067803, 4846.636502262415, 4849.127157111613, 4894.045661096052, 4370.978145109254, 4471.955280447154, 4476.9328460073775, 4476.955230447784, 4583.220852455024, 4778.593819525379, 4785.49752276006, 4796.928046079382, 4799.736014519235, 4843.660943733905, 4919.262110683426, 4923.753812309298, 4926.827561035347, 4931.3835770528685, 4977.4524802271, 4493.730376177309, 4599.770011499345, 4601.585857272861, 4608.147492713724, 4709.693869898446, 4718.7640617969655, 4749.24012158053, 4756.167670657552, 4757.072370887644, 4808.735519546459, 4625.560571745679, 4632.328312394617, 4645.930311045405, 4670.696404733681, 4695.859124226278, 4497.8200871964755, 4603.700759450759, 4614.561616646413, 4632.2819962905805, 4679.157751604744, 4550.7952142154345, 4557.4531056272135, 4578.862047360036, 4580.381648477412, 4592.770361481979], "unit": "ms", "name": "dojo.html", "value": 4433.636512680151}, {"lowerIsBetter": false, "replicates": [470.1889241059171, 481.05232691597587, 544.9046416877045, 549.162527146102, 557.9832605021851, 21702.674459883096, 22079.33761987141, 33991.32017359651, 34408.31183376331, 34491.482627760604, 40886.38670419939, 41066.794666026704, 41202.38196427056, 41284.793576032156, 41366.0, 6492.772752953648, 7989.960050199756, 8148.796280092985, 8163.755087347359, 8168.387370947203, 6578.177727784027, 10105.494725263745, 10377.533011014484, 10379.740506487322, 10381.636642717507, 10063.044010818998, 10189.796204075914, 10191.643292484765, 10192.490375481233, 10196.439195844225, 6641.203055633307, 6799.932000679979, 9628.374155679858, 9702.757431064245, 9916.851247231298, 9948.502574871227, 10086.0, 10094.596216151345, 10096.444695541742, 10100.040496152928, 36604.63395366039, 36948.07629809249, 37109.62890371089, 37235.255294894225, 37367.25265494675, 2555.565553855849, 2620.9868950655314, 2651.0, 2666.200139958005, 2752.518309295865, 28211.435771284665, 28407.147785566467, 28724.42551148965, 28829.0, 28957.276068098254, 3476.461148521983, 3508.1405055761247, 3541.787492750443, 3572.5712914450173, 3695.334839728848, 225461.0, 225968.0, 227386.0, 228525.0, 229477.0, 31947.680523194937, 55901.44098559044, 56291.43708562944, 56320.43679563234, 56344.43655563392, 31551.84224078865, 65537.0, 66737.33262667312, 66794.66602666955, 66885.33114668888, 12484.563040293546, 12736.23582585048, 12739.681507962376, 12754.872451275369, 12765.042621803215, 9331.813363732823, 9422.575984080733, 9429.0, 9430.90569094314, 9433.858492122623, 15756.212189390484, 15761.763573546406, 15797.36810527589, 15834.28745706446, 15893.364265429253, 7422.517536360119, 7812.218778122256, 7813.257740514642, 7887.177591383412, 7887.881681774778, 747.114669117098, 805.8106345008919, 830.8919840420707, 913.5158366065996, 925.6528801699362, 21807.563848722937, 21885.452863678216, 21979.560408791735, 22041.779582204294, 22093.226737064124, 897.2463130970017, 938.1837801113076, 1039.8024375368657, 1052.736815796051, 1052.9947350263199, 12373.061736008152, 12384.195027323196, 12435.191712538655, 12489.875101248872, 12509.937450312691, 272468.0, 277165.0, 277258.0, 277502.0, 277632.0, 45339.54660453419, 45753.77123114363, 45754.025988310656, 45762.0, 45859.77070114628, 1174.988250117505, 1187.5249900040053, 1192.7375977284983, 1195.0, 1208.812634041725, 23124.0, 24383.14658986927, 28485.287867803472, 29878.70121298759, 31079.223019424695, 42548.78725606352, 43661.12677746491, 43667.0, 43670.781646091564, 43695.781521093464, 228835.0, 235907.0, 253169.0, 253707.0, 255664.0, 35737.82131089432, 35839.0, 35982.46026309555, 36130.0, 36451.350040743724, 41353.58646413618, 41477.792611036755, 41508.1698366037, 41919.580804191566, 41955.7902210487, 35233.0, 35665.44292100618, 35888.82055589705, 36514.2614303923, 37083.814580926926, 33545.849967228394, 33672.49491257682, 34239.48640770341, 34406.82796586001, 34416.139596510286, 34451.4832277511, 35043.82478087695, 35073.29853402969, 35421.29157416786, 35440.822795885855, 30509.389812204077, 31107.533386999665, 31448.68551314549, 31497.8425107873, 31585.21036974094, 22045.22841700597, 22071.22750703782, 22178.889105554368, 22214.0, 24881.751182488668], "unit": "ms", "name": "ext.html", "value": 16991.06701736681}, {"lowerIsBetter": false, "replicates": [320.6969413903862, 334.79242869420955, 336.15121817411034, 336.94777309517025, 338.83227802237894, 10938.234323597351, 11260.887391126107, 14984.475543355984, 15426.305816238268, 15715.44995925143, 8966.462012279268, 8999.0, 9055.909440905589, 9283.4429934204, 9296.349255552097, 3992.4809774729315, 4651.930221046687, 4652.74409907455, 4655.348251244828, 4663.323818046381, 3232.2081090132833, 3305.5041743738393, 4572.702774319659, 4975.477574854643, 5093.26147708582, 5060.443351231362, 5088.618353623475, 5089.592832573385, 5104.8979020419565, 5110.105731496992, 4924.359833221676, 5026.321446604698, 5035.571976382012, 5071.391433028023, 5074.4671809460215, 4902.289168070645, 4906.533879281463, 4907.730074845882, 4910.9932463844825, 4911.828086017008, 11067.335959842436, 15294.770578441221, 17418.0, 17701.114944252735, 17703.468895933143, 1798.9550261243444, 1817.8636602254883, 1820.8907465552109, 1826.9086545672662, 1840.1167439628919, 8623.31013518917, 8854.690085847029, 8877.866831997526, 8940.46357218569, 12291.754164916652, 1478.7633978563379, 1584.6038490377405, 1734.037609126934, 1769.2745974150664, 1777.7866656001233, 53446.46553534493, 56032.0, 56531.71734141344, 56709.14936275959, 57196.714016430065, 9494.572744226527, 9700.126988571063, 9717.076877696607, 9790.657326993522, 9851.704448866545, 12464.875351246554, 12469.563565275172, 12477.251364918135, 12479.313637749829, 12484.937575312066, 6443.162388889508, 6473.417392434703, 6565.277819439858, 6565.606063636197, 6645.335466453316, 6006.099085137177, 6023.849403764941, 6074.7266373012435, 6075.3924607539775, 6084.726187321581, 3924.3132451820816, 3989.5212574491247, 3996.5603783583783, 4040.0909795295825, 4057.797110144481, 1422.4239183130849, 1454.0766613200694, 1454.6945141520187, 1651.4302565614844, 1662.709025920459, 642.8135840606266, 841.9536925469158, 909.1817364372118, 911.7310393433953, 962.5572236771163, 13091.345432728325, 14725.337359818834, 15007.699846003019, 15683.529494115195, 16242.593935151715, 817.1379194949267, 820.0610301205206, 844.6410275632832, 861.8664107063415, 872.7425409504211, 7834.6866125354345, 8976.820463590822, 9056.864147037799, 9174.816503669888, 9190.264778817678, 323766.0, 329465.0, 506196.0, 512160.0, 513140.0, 68522.65738671274, 70015.64992175007, 71460.0, 71660.64169679118, 73589.26410735931, 432.85283003778864, 441.5077188934315, 940.2618944128826, 964.9421034737938, 967.6758285974278, 9030.096990300917, 9269.026752190923, 9307.488088155216, 9438.48088355147, 9503.382280151767, 31353.21616959503, 33048.50427243641, 33184.834075829465, 34178.0, 34414.82792586021, 42412.36381454342, 43613.345799813666, 43869.561304386545, 44276.77861610671, 46092.30861537147, 8760.912390876265, 8781.331547006048, 9000.279977601907, 9008.189262966365, 9039.412438191497, 10435.0, 15512.84487155114, 16120.516384508484, 16469.505914822574, 16502.75245871337, 9327.58025888823, 9738.074882886114, 11988.340641264465, 12458.127931044739, 12582.30797306157, 12361.567345142877, 12725.0, 12859.678508037374, 13007.154534955198, 13073.0, 9832.754181145528, 12187.573434929735, 12332.876671233173, 12408.81386779217, 12804.359782011048, 6330.905036424365, 8596.957015214884, 8613.052564218056, 8650.610722517376, 8670.393072485118, 8503.149685031447, 9493.0, 12660.11379203447, 13234.470621175045, 13255.204687718382], "unit": "ms", "name": "jquery.html", "value": 7590.468778338061}, {"lowerIsBetter": false, "replicates": [898.5103118800254, 1313.6158665747269, 1389.1387339849296, 1392.6796836727553, 1469.2286549561486, 5239.187925871492, 6649.135612370391, 6753.290904455035, 6761.526693131483, 6761.763338283161, 6628.270890202074, 6715.865682686355, 6743.730250789975, 6768.357006084414, 6786.321367863211, 1683.9579010524712, 1716.2877405876545, 1988.7911769264235, 2013.5368865161022, 2055.784142665021, 1975.150685205361, 1975.5456245063644, 1981.5739615982561, 1981.9207231710714, 1982.0585222019497, 1973.2304401283438, 1986.1161783006496, 2015.193922431032, 2036.511237303044, 2038.4598081508339, 1978.436145698469, 1989.9602007959832, 2007.1068374573322, 2026.0, 2026.2199053364486, 2062.1442101527846, 2080.355089922129, 2084.030925619594, 2085.4786303424144, 2086.5096702274955, 6587.5718078325235, 6635.966820165917, 6640.468762498988, 6652.168478940132, 6659.9001014984815, 3774.301754175486, 3800.6769424598942, 3839.827207775657, 3854.6338097880657, 3866.284737323576, 2143.582001509706, 2545.6945166579944, 2595.4160313929406, 2627.38256509722, 2629.789616830668, 756.7200135949679, 832.9541875196862, 838.5890913452425, 863.8617821148649, 874.9212570868652, 8755.124487551258, 8802.383833131684, 8802.64789408423, 8817.382783205177, 8824.249938755149, 3605.5853576838476, 3627.5828279748166, 3634.545681789776, 3667.1015601177883, 3685.041889108851, 7321.341079302888, 7324.63376831167, 7335.486515943832, 7344.70621175147, 7348.595827229554, 3806.0, 3806.410006449005, 3811.2187001664593, 3814.7520411173186, 3824.1395685970433, 3436.0207340907723, 3473.0, 3476.14834365577, 3483.320752453247, 3487.075924879909, 3144.4182826176775, 3147.291859331632, 3191.9042428727175, 3197.840107994591, 3199.2161920329204, 989.2827699917502, 997.2819569909653, 999.1906555689915, 1006.6225165562914, 1007.189212683782, 750.6021808441535, 875.7066382761847, 877.0527829943645, 891.5319457284847, 891.8038031633031, 5775.16260142277, 5999.460048595647, 6007.729652165663, 6012.789552365646, 6017.638941663514, 921.6774129054911, 926.420986883198, 1012.6101450941441, 1021.2187676427538, 1032.1897310611134, 4683.110209060335, 4766.713997160182, 4795.544423279783, 4806.134895718804, 4846.80612775492, 6974.686139123752, 7205.4595905307315, 7986.201379862084, 8179.754607361789, 8273.669053237803, 7761.805954851174, 7788.065432148179, 7825.647845846836, 7903.762887113396, 7909.050913890255, 6140.785072522441, 6256.405641464054, 6309.3690630936535, 6310.116583678288, 6312.968435157794, 5965.821025369072, 6178.752849886134, 6189.690515474118, 6191.00943849, 6198.163247961648, 7251.0, 7410.814729631802, 7429.33136017761, 7438.92561074404, 7445.553266804009, 7347.66935487915, 7495.812604684708, 7603.353714934293, 7604.42966777505, 7671.923280767344, 5446.101393270224, 5523.861903452445, 5525.944740552543, 5528.612997090326, 5536.52939500147, 6233.937660623517, 6311.842203944938, 6348.079528468438, 6363.7772677956045, 6368.203974503187, 5806.042003069446, 5844.561657875592, 5888.352281248974, 5906.497947674496, 5998.280206375263, 5832.679202643895, 5837.066069428871, 5902.734376952962, 5951.523878089656, 5971.940280597139, 5783.074708046693, 5790.073588225863, 5800.9419905800405, 5845.064789633639, 5862.355140934579, 5094.363204599425, 5437.728113594384, 5526.447355264441, 5536.390996990247, 5542.667439953616, 5506.256655351636, 5542.944570554243, 5557.833265002057, 5563.972180139235, 5567.721613919369], "unit": "ms", "name": "mootools.html", "value": 3779.3524400882566}, {"lowerIsBetter": false, "replicates": [289.9637545306837, 294.74946295648704, 299.2862024072587, 299.77516862353247, 305.90364035328884, 5156.2265660151, 5219.668984408975, 5258.342707161605, 5293.550048245904, 5311.60162987776, 5156.587473002161, 5204.34945631796, 5207.531322181003, 5224.503672151149, 5232.372115346155, 4083.060895993923, 4091.0999580092334, 4091.304478238692, 4092.0997380576373, 4092.242935057009, 4061.0862555924828, 4085.3667681509264, 4086.284900142478, 4090.0797320602774, 4095.7542547447247, 3979.084810493588, 4040.4545386372906, 4062.939055914164, 4065.9390109148385, 4069.877903662895, 4035.7174997750317, 4049.088954985134, 4051.270771261172, 4063.6342729154517, 4066.3087275163293, 3568.553930758655, 3572.4105522588743, 3572.821358932069, 3579.7494175407733, 3588.372034893909, 5058.595312375038, 5059.62052846038, 5063.291139240509, 5065.4174769901565, 5069.594432445396, 4684.156851766681, 4684.742339171345, 4686.343911852344, 4688.859334219979, 4689.695169813986, 5309.840704778863, 5483.232347471358, 5491.615586908918, 5494.642848214853, 5506.650870536744, 3792.563855156665, 3800.923981520382, 3809.2381523695094, 3812.1994381179984, 3814.618538146191, 5577.191307260465, 5685.488306052475, 5705.201271821907, 5792.275965504312, 5799.18811366409, 3784.5647750509042, 3829.272438236726, 3840.462335273064, 3856.807159642007, 3872.1094148346037, 3900.7854567999034, 3905.0432644002403, 3905.7851818150275, 3905.882823515299, 3908.413737939332, 4301.07526881722, 4391.231534481453, 4502.954970450253, 4505.977470112629, 4586.2661974083985, 5506.724663766876, 5513.531349835309, 5514.172874068921, 5515.227868098469, 5521.2270282160525, 1387.61840493865, 1401.0962928911, 1402.712443948988, 1402.9929850350886, 1403.2422491854284, 935.3172184305495, 938.596403546468, 949.2216382566368, 963.6530848894392, 966.7824739433712, 4870.439899411542, 4880.0, 4880.95119048805, 4887.902241955212, 4887.975560122177, 5697.971510142505, 5728.51307638847, 5736.627119237236, 5740.885182296331, 5741.081426971748, 4865.099956508057, 4869.975650121727, 4870.050340183701, 4871.634627402959, 4874.439439464436, 3009.864556094981, 3054.266975925806, 3060.9234769130503, 3089.4130115278026, 3092.9381412372077, 5411.810586629449, 5414.133738601805, 5417.972910135424, 5418.647787893774, 5434.809781657623, 5883.294004719461, 5889.322727886348, 5900.203472531153, 5906.0, 5908.05471124618, 5428.5114339708825, 5430.294061771944, 5434.0, 5436.266104075899, 5439.5104440600535, 5664.348599911063, 5732.627379220337, 5809.128630705428, 5809.709514524172, 5812.3025236971835, 5623.831285061455, 5647.040003199384, 5648.378678345297, 5653.604247702621, 5662.688552129673, 5480.068388374066, 5488.4237155098135, 5493.7802487900035, 5502.174673798962, 5503.9174412383045, 3873.3608954522188, 3927.5876033017266, 3967.206558688332, 3967.92064158721, 3970.0273433009097, 5518.255035570147, 5695.117256825199, 5785.942140578541, 5790.26292112373, 5796.42035796417, 5457.20870473787, 5555.944440555704, 5586.916196257141, 5588.804391846266, 5589.916151257816, 5555.694436806015, 5566.582506311962, 5570.3315602128005, 5573.442655734394, 5585.469380408855, 5309.814156504503, 5432.538234249975, 5437.4562543745305, 5440.700761458158, 5450.836474905759, 5608.747606357642, 5611.372701916399, 5618.101103823368, 5628.887422251614, 5629.859253518531, 5479.972600136974, 5480.643758155867, 5481.985832620978, 5485.396606373375, 5488.890222195613], "unit": "ms", "name": "prototype.html", "value": 4142.263712545357}, {"lowerIsBetter": false, "replicates": [693.6670398208856, 695.7808290388527, 747.1184002876605, 756.2928661701308, 764.9158592554815, 10662.946685266572, 10927.726806829824, 11062.1703372247, 11777.116716246295, 11815.881841181586, 11947.701307467318, 11953.10351723622, 11963.641090767269, 11968.102392320567, 11970.34163121028, 350.556545969349, 352.8923678278124, 752.3003606645844, 758.5562445969101, 776.2974508070178, 763.0995425398028, 764.5107131435885, 770.4067867741835, 770.660909199953, 770.9575973321465, 805.8589746794316, 812.8455593437228, 813.0974618173823, 813.5606772342928, 813.9023317201944, 361.84983231958705, 364.83035388544323, 792.0693185507006, 803.3813963248266, 805.3718099882043, 587.0694948506622, 590.3181824992098, 591.6923199936052, 592.3661682000261, 593.486634061538, 11542.249753765978, 11695.7076073098, 11705.53177872884, 11711.765764684658, 11716.589919352868, 10368.274220804547, 10736.409497477636, 11233.887661123366, 11613.419329033515, 11814.350210738407, 8624.913750862537, 8803.955980220058, 9016.819663606757, 9152.4966126863, 9545.90454095457, 3230.370077834823, 3353.6478669739813, 3378.2230087079865, 3379.7634165608415, 3380.780249283813, 40607.7969610153, 40949.385759213634, 40955.180896381906, 40971.1805763883, 41013.0, 9330.729347384224, 9453.669121580711, 9704.70885873425, 9833.557489912828, 9850.704478865502, 17005.91497042507, 17023.14884255782, 17028.659426811395, 17084.316627335014, 17515.036672983108, 6540.37866402691, 6569.474442044625, 6615.073889655452, 6760.0, 6858.6570671466225, 3464.8614055438006, 3483.9303213936087, 3546.0957455848593, 3568.3398571264397, 3570.6786389225094, 2493.8379005364955, 2533.784628306578, 2535.4168541235617, 2537.0, 2537.061287323702, 458.1478450082843, 458.4521496811279, 460.77422063188794, 485.42234740658506, 485.47326151126424, 415.82743161587604, 431.73016864459714, 459.6254052946838, 484.06333744205074, 484.30018623089296, 6992.965035174791, 7059.399951004119, 7187.38907192884, 7238.239984801626, 7240.493165478366, 399.3111882003579, 436.1821584529008, 488.19447910947224, 501.1980830670897, 536.7048123532041, 3311.3542859142717, 3325.0, 3354.7483938704695, 3457.896263112111, 3512.877049303313, 50881.236781447566, 51343.48656513462, 51415.0, 55155.0, 55744.0, 44407.55592444099, 44544.10911781811, 44562.0, 44787.328190077176, 44802.77598611986, 40744.18511629751, 40980.180396392505, 41316.1736765263, 41855.58144418517, 41939.99999999939, 7088.716451341888, 7122.6438678066925, 7141.53580017318, 7269.7455589054125, 7475.813104672209, 31470.68529314769, 31886.681133188373, 32121.196970075936, 32140.0, 32431.189220268738, 36091.458628120075, 37506.62493375031, 39638.405423918084, 39856.402153968294, 40130.197396051335, 9313.627454901729, 9593.088656577615, 9620.470874101991, 9651.227901767983, 9693.563789629625, 9658.75853103678, 9694.127528522467, 9871.851922221316, 10048.09567138961, 10632.096271816983, 9595.0, 9604.95197524036, 9728.464934428392, 9751.658691946031, 9865.556049977624, 9581.904180958101, 9649.758756031155, 9756.26827987918, 9828.754281142743, 9837.360571562825, 7797.649105790139, 9915.702528924145, 10017.649382271586, 10183.592656293666, 10715.732106697084, 7123.074000379917, 7373.446991475768, 7517.248275172439, 7685.5004424712215, 7763.92236077632, 7381.963090184515, 7771.572563508835, 7791.4935529190425, 7819.335356494534, 7894.960525197337], "unit": "ms", "name": "yui.html", "value": 5401.7869668210715}], "name": "dromaeo_css", "value": 6035.990052906905}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 113.0, 106.0, 112.0, 113.0, 112.0, 102.0, 118.0, 115.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.8}, {"lowerIsBetter": true, "replicates": [157.0, 137.0, 156.0, 171.0, 131.0, 160.0, 152.0, 134.0, 168.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.6}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 162.0, 162.0, 161.0, 163.0, 163.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 161.8}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 88.0, 91.0, 72.0, 72.0, 72.0, 92.0, 88.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [95.0, 94.0, 139.0, 94.0, 95.0, 94.0, 130.0, 94.0, 94.0, 125.0], "unit": "ms", "name": "audio-oscillator", "value": 105.4}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.7}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 147.0, 146.0, 147.0, 147.0, 147.0, 146.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.4}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 94.0, 95.0, 95.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 94.9}, {"lowerIsBetter": true, "replicates": [72.0, 71.0, 71.0, 73.0, 72.0, 72.0, 72.0, 71.0, 73.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 71.8}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 69.0, 68.0, 69.0, 69.0, 69.0, 68.0, 77.0, 70.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.7}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 84.0, 84.0, 83.0, 85.0, 83.0, 84.0, 83.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [128.0, 120.0, 118.0, 126.0, 125.0, 117.0, 128.0, 120.0, 126.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [146.0, 137.0, 149.0, 139.0, 147.0, 148.0, 150.0, 147.0, 145.0, 140.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 144.8}, {"lowerIsBetter": true, "replicates": [71.0, 68.0, 69.0, 68.0, 70.0, 70.0, 71.0, 70.0, 70.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.5}], "name": "kraken", "value": 1520.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [164.58196181698486], "unit": "score", "name": "Richards", "value": 214.4949520000001}, {"lowerIsBetter": false, "replicates": [194.47685725398676], "unit": "score", "name": "DeltaBlue", "value": 339.9787560000001}, {"lowerIsBetter": false, "replicates": [283.04557033682426], "unit": "score", "name": "Encrypt", "value": 940.4174729999997}, {"lowerIsBetter": false, "replicates": [5128.205128205128], "unit": "score", "name": "Decrypt", "value": 51.90529499999997}, {"lowerIsBetter": false, "replicates": [1988.0715705765408], "unit": "score", "name": "RayTrace", "value": 372.21446699999984}, {"lowerIsBetter": false, "replicates": [792.5574030087095], "unit": "score", "name": "Earley", "value": 840.9018671328672}, {"lowerIsBetter": false, "replicates": [12390.243902439024], "unit": "score", "name": "Boyer", "value": 53.789336614173266}, {"lowerIsBetter": false, "replicates": [26552.63157894737], "unit": "score", "name": "RegExp", "value": 34.3086521308226}, {"lowerIsBetter": false, "replicates": [650.1950585175553], "unit": "score", "name": "Splay", "value": 125.33315799999995}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19565.923031493112}]} 06:44:39 INFO - RETURN: dromaeo_css: 6035.99 06:44:39 INFO - RETURN: kraken: 1520.50 06:44:39 INFO - RETURN: v8_7: 19565.92 06:44:39 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19565.92"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1520.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6035.99"}}} 06:44:39 INFO - Return code: 0 06:44:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 06:44:39 INFO - # TBPL SUCCESS # 06:44:39 INFO - Running post-action listener: _resource_record_post_action 06:44:39 INFO - Running post-run listener: _resource_record_post_run 06:44:40 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 12288; Write bytes: 520044544; Read time: 208; Write time: 586352 06:44:40 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 4096; Write bytes: 246673408; Read time: 144; Write time: 376200 06:44:40 INFO - run-tests - Wall time: 1217s; CPU: 13.0%; Read bytes: 8192; Write bytes: 273371136; Read time: 64; Write time: 210152 06:44:40 INFO - Running post-run listener: _upload_blobber_files 06:44:40 INFO - Blob upload gear active. 06:44:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 06:44:40 INFO - Copying logs to upload dir... 06:44:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1265.781658 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2015-11-25 06:44:40.668266) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-25 06:44:40.671975) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009913 build_url: 'https://queue.taskcluster.net/v1/task/SjRC_DlOQAmRtps6-0mAiA/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 06:44:40.725052) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:44:40.725391) ========= 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=f5f5a079460e1a9be8676904000001c1-1448461076.724636-1023286706 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004557 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-25 06:44:40.775427) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 06:44:40.775748) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-25 06:44:40.776147) ========= ========= Total master_lag: 0.26 =========