builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-059 starttime: 1448328333.21 results: success (0) buildid: 20151123165430 builduid: 510f427d61d04cda9ccb2f409533fbab revision: c9131227ffdeee42cb1a3b4209b704e94c7bc177 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.208118) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.208613) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.208940) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006583 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.231695) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.232015) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.247241) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.247631) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004609 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.298711) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.299039) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.299412) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.299719) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-23 17:25:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-11-23 17:25:33 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.216295 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.528440) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.528825) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017638 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:33.578050) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:25:33.578406) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev c9131227ffdeee42cb1a3b4209b704e94c7bc177 --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 c9131227ffdeee42cb1a3b4209b704e94c7bc177 --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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-23 17:25:34,003 truncating revision to first 12 chars 2015-11-23 17:25:34,003 Setting DEBUG logging. 2015-11-23 17:25:34,003 attempt 1/10 2015-11-23 17:25:34,003 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/c9131227ffde?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-23 17:25:35,085 unpacking tar archive at: b2g-inbound-c9131227ffde/testing/mozharness/ program finished with exit code 0 elapsedTime=1.358668 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-23 17:25:34.949272) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:34.949584) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:34.960858) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:34.961198) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-23 17:25:34.961636) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 17:25:34.961942) ========= /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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 17:25:35 INFO - MultiFileLogger online at 20151123 17:25:35 in /builds/slave/test 17:25: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 17:25:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 17:25:35 INFO - {'append_to_log': False, 17:25:35 INFO - 'base_work_dir': '/builds/slave/test', 17:25:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 17:25:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 17:25:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 17:25:35 INFO - 'buildbot_json_path': 'buildprops.json', 17:25:35 INFO - 'config_files': ('talos/linux_config.py',), 17:25:35 INFO - 'default_actions': ('clobber', 17:25:35 INFO - 'read-buildbot-config', 17:25:35 INFO - 'download-and-extract', 17:25:35 INFO - 'populate-webroot', 17:25:35 INFO - 'create-virtualenv', 17:25:35 INFO - 'install', 17:25:35 INFO - 'run-tests'), 17:25:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 17:25:35 INFO - 'download_minidump_stackwalk': True, 17:25:35 INFO - 'download_symbols': 'ondemand', 17:25:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 17:25:35 INFO - 'tooltool.py': '/tools/tooltool.py', 17:25:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 17:25:35 INFO - '/tools/misc-python/virtualenv.py')}, 17:25:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 17:25:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 17:25:35 INFO - 'installer_path': 'installer.exe', 17:25:35 INFO - 'log_level': 'info', 17:25:35 INFO - 'log_name': 'talos', 17:25:35 INFO - 'log_to_console': True, 17:25:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 17:25:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 17:25:35 INFO - 'opt_config_files': (), 17:25:35 INFO - 'pip_index': False, 17:25:35 INFO - 'sps_profile': False, 17:25:35 INFO - 'sps_profile_interval': 0, 17:25:35 INFO - 'suite': 'dromaeojs', 17:25:35 INFO - 'system_bits': '64', 17:25:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 17:25:35 INFO - 'title': 'talos-linux64-ix-059', 17:25:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 17:25:35 INFO - 'use_talos_json': True, 17:25:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 17:25:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 17:25:35 INFO - 'work_dir': 'build'} 17:25:35 INFO - ##### 17:25:35 INFO - ##### Running clobber step. 17:25:35 INFO - ##### 17:25:35 INFO - Running pre-action listener: _resource_record_pre_action 17:25:35 INFO - Running main action method: clobber 17:25:35 INFO - rmtree: /builds/slave/test/build 17:25:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 17:25:35 INFO - Running post-action listener: _resource_record_post_action 17:25:35 INFO - ##### 17:25:35 INFO - ##### Running read-buildbot-config step. 17:25:35 INFO - ##### 17:25:35 INFO - Running pre-action listener: _resource_record_pre_action 17:25:35 INFO - Running main action method: read_buildbot_config 17:25:35 INFO - Using buildbot properties: 17:25:35 INFO - { 17:25:35 INFO - "properties": { 17:25:35 INFO - "buildnumber": 280, 17:25:35 INFO - "product": "firefox", 17:25:35 INFO - "script_repo_revision": "production", 17:25:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 17:25:35 INFO - "repository": "", 17:25:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 17:25:35 INFO - "buildid": "20151123165430", 17:25:35 INFO - "slavename": "talos-linux64-ix-059", 17:25:35 INFO - "pgo_build": "False", 17:25:35 INFO - "basedir": "/builds/slave/test", 17:25:35 INFO - "project": "", 17:25:35 INFO - "platform": "ubuntu64_hw", 17:25:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 17:25:35 INFO - "slavebuilddir": "test", 17:25:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 17:25:35 INFO - "branch": "b2g-inbound", 17:25:35 INFO - "repo_path": "integration/b2g-inbound", 17:25:35 INFO - "stage_platform": "linux64", 17:25:35 INFO - "builduid": "510f427d61d04cda9ccb2f409533fbab", 17:25:35 INFO - "revision": "c9131227ffdeee42cb1a3b4209b704e94c7bc177" 17:25:35 INFO - }, 17:25:35 INFO - "sourcestamp": { 17:25:35 INFO - "repository": "", 17:25:35 INFO - "hasPatch": false, 17:25:35 INFO - "project": "", 17:25:35 INFO - "branch": "b2g-inbound-linux64-talos", 17:25:35 INFO - "changes": [ 17:25:35 INFO - { 17:25:35 INFO - "category": null, 17:25:35 INFO - "files": [ 17:25:35 INFO - { 17:25:35 INFO - "url": null, 17:25:35 INFO - "name": "https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 17:25:35 INFO - } 17:25:35 INFO - ], 17:25:35 INFO - "repository": "", 17:25:35 INFO - "rev": "c9131227ffdeee42cb1a3b4209b704e94c7bc177", 17:25:35 INFO - "who": "kwierso@gmail.com", 17:25:35 INFO - "when": 1448328327, 17:25:35 INFO - "number": 6698227, 17:25:35 INFO - "comments": "Merge m-c to b2ginbound, a=merge", 17:25:35 INFO - "project": "", 17:25:35 INFO - "at": "Mon 23 Nov 2015 17:25:27", 17:25:35 INFO - "branch": "b2g-inbound-linux64-talos", 17:25:35 INFO - "revlink": "", 17:25:35 INFO - "properties": [ 17:25:35 INFO - [ 17:25:35 INFO - "buildid", 17:25:35 INFO - "20151123165430", 17:25:35 INFO - "Change" 17:25:35 INFO - ], 17:25:35 INFO - [ 17:25:35 INFO - "builduid", 17:25:35 INFO - "510f427d61d04cda9ccb2f409533fbab", 17:25:35 INFO - "Change" 17:25:35 INFO - ], 17:25:35 INFO - [ 17:25:35 INFO - "pgo_build", 17:25:35 INFO - "False", 17:25:35 INFO - "Change" 17:25:35 INFO - ] 17:25:35 INFO - ], 17:25:35 INFO - "revision": "c9131227ffdeee42cb1a3b4209b704e94c7bc177" 17:25:35 INFO - } 17:25:35 INFO - ], 17:25:35 INFO - "revision": "c9131227ffdeee42cb1a3b4209b704e94c7bc177" 17:25:35 INFO - } 17:25:35 INFO - } 17:25:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 17:25:35 INFO - Running post-action listener: _resource_record_post_action 17:25:35 INFO - ##### 17:25:35 INFO - ##### Running download-and-extract step. 17:25:35 INFO - ##### 17:25:35 INFO - Running pre-action listener: _resource_record_pre_action 17:25:35 INFO - Running main action method: download_and_extract 17:25:35 INFO - mkdir: /builds/slave/test/build/tests 17:25:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:35 INFO - https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 17:25:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/test_packages.json 17:25:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/test_packages.json 17:25:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 17:25:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 17:25:37 INFO - Downloaded 1302 bytes. 17:25:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 17:25:37 INFO - Using the following test package requirements: 17:25:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 17:25:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'jsshell-linux-x86_64.zip'], 17:25:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 17:25:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 17:25:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 17:25:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 17:25:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 17:25:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 17:25:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 17:25:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 17:25:37 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')]} 17:25:37 INFO - https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:39 INFO - Downloaded 21341474 bytes. 17:25:39 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 17:25:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:39 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 17:25:40 INFO - Return code: 0 17:25:40 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 17:25:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:40 INFO - https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 17:25:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:41 INFO - Downloaded 21341474 bytes. 17:25:41 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 17:25:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 17:25:41 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 17:25:42 INFO - Return code: 0 17:25:42 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')]} 17:25:42 INFO - https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 17:25:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:44 INFO - Downloaded 11130997 bytes. 17:25: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 17:25:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 17:25: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 17:25:44 INFO - Return code: 0 17:25:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 17:25:44 INFO - https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 17:25:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/_CkPG0N3TLmjxorbDBCisA/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 17:25:47 INFO - Downloaded 56025184 bytes. 17:25:47 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:47 INFO - mkdir: /builds/slave/test/properties 17:25:47 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 17:25:47 INFO - Writing to file /builds/slave/test/properties/build_url 17:25:47 INFO - Contents: 17:25:47 INFO - build_url:https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 17:25:47 INFO - Running post-action listener: _resource_record_post_action 17:25:47 INFO - Running post-action listener: set_extra_try_arguments 17:25:47 INFO - ##### 17:25:47 INFO - ##### Running populate-webroot step. 17:25:47 INFO - ##### 17:25:47 INFO - Running pre-action listener: _resource_record_pre_action 17:25:47 INFO - Running main action method: populate_webroot 17:25:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 17:25:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 17:25:47 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 17:25:47 INFO - '../fennec_ids.txt'], 17:25:47 INFO - 'tests': ['tcheck2']}, 17:25:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 17:25:47 INFO - '--tppagecycles', 17:25:47 INFO - '7'], 17:25:47 INFO - 'tests': ['tsvgm']}}, 17:25:47 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 17:25:47 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 17:25:47 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:47 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 17:25:47 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:47 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 17:25:47 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'tests': ['damp', 'tps']}, 17:25:47 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['damp', 'tps']}, 17:25:47 INFO - 'g3': {'tests': ['dromaeo_dom']}, 17:25:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 17:25:47 INFO - 'other': {'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'other-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'other_l64': {'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'other_nol64': {'tests': ['a11yr', 17:25:47 INFO - 'ts_paint', 17:25:47 INFO - 'tpaint', 17:25:47 INFO - 'sessionrestore', 17:25:47 INFO - 'sessionrestore_no_auto_restore']}, 17:25:47 INFO - 'svgr': {'tests': ['tsvgx', 17:25:47 INFO - 'tsvgr_opacity', 17:25:47 INFO - 'tart', 17:25:47 INFO - 'tscrollx', 17:25:47 INFO - 'cart']}, 17:25:47 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['tsvgx', 17:25:47 INFO - 'tsvgr_opacity', 17:25:47 INFO - 'tart', 17:25:47 INFO - 'tscrollx', 17:25:47 INFO - 'cart']}, 17:25:47 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'tests': ['tp5o']}, 17:25:47 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--e10s'], 17:25:47 INFO - 'tests': ['tp5o']}, 17:25:47 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--xperf_path', 17:25:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:47 INFO - 'tests': ['tp5n']}, 17:25:47 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 17:25:47 INFO - 'talos_options': ['--e10s', 17:25:47 INFO - '--xperf_path', 17:25:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 17:25:47 INFO - 'tests': ['tp5n']}}, 17:25:47 INFO - 'talos.zip': {'path': '', 17:25:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 17:25:47 INFO - Running post-action listener: _resource_record_post_action 17:25:47 INFO - ##### 17:25:47 INFO - ##### Running create-virtualenv step. 17:25:47 INFO - ##### 17:25:47 INFO - Running pre-action listener: _resource_record_pre_action 17:25:47 INFO - Running main action method: create_virtualenv 17:25:47 INFO - Creating virtualenv /builds/slave/test/build/venv 17:25: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 17:25:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 17:25:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 17:25:47 INFO - Using real prefix '/usr' 17:25:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 17:25:47 INFO - Installing distribute.............................................................................................................................................................................................done. 17:25:49 INFO - Installing pip.................done. 17:25:49 INFO - Return code: 0 17:25:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:25: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 17:25: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 17:25:49 INFO - Using env: {'DISPLAY': ':0', 17:25:49 INFO - 'HOME': '/home/cltbld', 17:25:49 INFO - 'LANG': 'en_US.UTF-8', 17:25:49 INFO - 'LANGUAGE': 'en_US:en', 17:25:49 INFO - 'LOGNAME': 'cltbld', 17:25:49 INFO - 'MAIL': '/var/mail/cltbld', 17:25:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:49 INFO - 'MOZ_NO_REMOTE': '1', 17:25:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:49 INFO - 'NO_EM_RESTART': '1', 17:25:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:49 INFO - 'PWD': '/builds/slave/test', 17:25:49 INFO - 'SHELL': '/bin/bash', 17:25:49 INFO - 'SHLVL': '1', 17:25:49 INFO - 'TERM': 'linux', 17:25:49 INFO - 'TMOUT': '86400', 17:25:49 INFO - 'USER': 'cltbld', 17:25:49 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:25:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:49 INFO - '_': '/tools/buildbot/bin/python'} 17:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25: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 17:25:50 INFO - Cleaning up... 17:25:50 INFO - Return code: 0 17:25:50 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:25: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 17:25: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 17:25:50 INFO - Using env: {'DISPLAY': ':0', 17:25:50 INFO - 'HOME': '/home/cltbld', 17:25:50 INFO - 'LANG': 'en_US.UTF-8', 17:25:50 INFO - 'LANGUAGE': 'en_US:en', 17:25:50 INFO - 'LOGNAME': 'cltbld', 17:25:50 INFO - 'MAIL': '/var/mail/cltbld', 17:25:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:50 INFO - 'MOZ_NO_REMOTE': '1', 17:25:50 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:50 INFO - 'NO_EM_RESTART': '1', 17:25:50 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:50 INFO - 'PWD': '/builds/slave/test', 17:25:50 INFO - 'SHELL': '/bin/bash', 17:25:50 INFO - 'SHLVL': '1', 17:25:50 INFO - 'TERM': 'linux', 17:25:50 INFO - 'TMOUT': '86400', 17:25:50 INFO - 'USER': 'cltbld', 17:25:50 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:25:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:50 INFO - '_': '/tools/buildbot/bin/python'} 17:25:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:50 INFO - Downloading/unpacking psutil>=0.7.1 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:52 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 17:25:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 17:25:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 17:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:52 INFO - Installing collected packages: psutil 17:25:52 INFO - Running setup.py install for psutil 17:25:52 INFO - building 'psutil._psutil_linux' extension 17:25: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 17:25: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 17:25:52 INFO - building 'psutil._psutil_posix' extension 17:25: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 17:25: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 17:25:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 17:25:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 17:25:52 INFO - Successfully installed psutil 17:25:52 INFO - Cleaning up... 17:25:52 INFO - Return code: 0 17:25:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:25: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 17:25: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 17:25:52 INFO - Using env: {'DISPLAY': ':0', 17:25:52 INFO - 'HOME': '/home/cltbld', 17:25:52 INFO - 'LANG': 'en_US.UTF-8', 17:25:52 INFO - 'LANGUAGE': 'en_US:en', 17:25:52 INFO - 'LOGNAME': 'cltbld', 17:25:52 INFO - 'MAIL': '/var/mail/cltbld', 17:25:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:52 INFO - 'MOZ_NO_REMOTE': '1', 17:25:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:52 INFO - 'NO_EM_RESTART': '1', 17:25:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:52 INFO - 'PWD': '/builds/slave/test', 17:25:52 INFO - 'SHELL': '/bin/bash', 17:25:52 INFO - 'SHLVL': '1', 17:25:52 INFO - 'TERM': 'linux', 17:25:52 INFO - 'TMOUT': '86400', 17:25:52 INFO - 'USER': 'cltbld', 17:25:52 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:25:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:52 INFO - '_': '/tools/buildbot/bin/python'} 17:25:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 17:25:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 17:25:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 17:25: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) 17:25:54 INFO - Installing collected packages: mozsystemmonitor 17:25:54 INFO - Running setup.py install for mozsystemmonitor 17:25:54 INFO - Successfully installed mozsystemmonitor 17:25:54 INFO - Cleaning up... 17:25:54 INFO - Return code: 0 17:25:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 17:25: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')]} 17:25:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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')]} 17:25:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:25: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 17:25: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 17:25:54 INFO - Using env: {'DISPLAY': ':0', 17:25:54 INFO - 'HOME': '/home/cltbld', 17:25:54 INFO - 'LANG': 'en_US.UTF-8', 17:25:54 INFO - 'LANGUAGE': 'en_US:en', 17:25:54 INFO - 'LOGNAME': 'cltbld', 17:25:54 INFO - 'MAIL': '/var/mail/cltbld', 17:25:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:54 INFO - 'MOZ_NO_REMOTE': '1', 17:25:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:54 INFO - 'NO_EM_RESTART': '1', 17:25:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:54 INFO - 'PWD': '/builds/slave/test', 17:25:54 INFO - 'SHELL': '/bin/bash', 17:25:54 INFO - 'SHLVL': '1', 17:25:54 INFO - 'TERM': 'linux', 17:25:54 INFO - 'TMOUT': '86400', 17:25:54 INFO - 'USER': 'cltbld', 17:25:54 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:25:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:54 INFO - '_': '/tools/buildbot/bin/python'} 17:25:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:54 INFO - Downloading/unpacking blobuploader==1.2.4 17:25:54 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 17:25:54 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 17:25:54 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 17:25:54 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 17:25:54 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 17:25:54 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 17:25:56 INFO - Downloading blobuploader-1.2.4.tar.gz 17:25:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 17:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 17:25:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 17:25:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 17:25:57 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25: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 17:25:57 INFO - Downloading docopt-0.6.1.tar.gz 17:25:57 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 17:25:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 17:25:57 INFO - Installing collected packages: blobuploader, requests, docopt 17:25:57 INFO - Running setup.py install for blobuploader 17:25:57 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 17:25:57 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 17:25:57 INFO - Running setup.py install for requests 17:25:57 INFO - Running setup.py install for docopt 17:25:57 INFO - Successfully installed blobuploader requests docopt 17:25:57 INFO - Cleaning up... 17:25:57 INFO - Return code: 0 17:25:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:25:57 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')]} 17:25:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:25:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:57 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')]} 17:25:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:25:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:25:57 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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:25:57 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 17:25:57 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 17:25:57 INFO - Using env: {'DISPLAY': ':0', 17:25:57 INFO - 'HOME': '/home/cltbld', 17:25:57 INFO - 'LANG': 'en_US.UTF-8', 17:25:57 INFO - 'LANGUAGE': 'en_US:en', 17:25:57 INFO - 'LOGNAME': 'cltbld', 17:25:57 INFO - 'MAIL': '/var/mail/cltbld', 17:25:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:25:57 INFO - 'MOZ_NO_REMOTE': '1', 17:25:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:25:57 INFO - 'NO_EM_RESTART': '1', 17:25:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:25:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:25:57 INFO - 'PWD': '/builds/slave/test', 17:25:57 INFO - 'SHELL': '/bin/bash', 17:25:57 INFO - 'SHLVL': '1', 17:25:57 INFO - 'TERM': 'linux', 17:25:57 INFO - 'TMOUT': '86400', 17:25:57 INFO - 'USER': 'cltbld', 17:25:57 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:25:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:25:57 INFO - '_': '/tools/buildbot/bin/python'} 17:25:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:25:58 INFO - Running setup.py (path:/tmp/pip-EAvccN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:25:58 INFO - Running setup.py (path:/tmp/pip-cgfURN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:25:58 INFO - Running setup.py (path:/tmp/pip-cJqeV9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:25:58 INFO - Running setup.py (path:/tmp/pip-srKZVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:25:58 INFO - Running setup.py (path:/tmp/pip-vvt4Z8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:25:58 INFO - Running setup.py (path:/tmp/pip-gY9nkm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:25:58 INFO - Running setup.py (path:/tmp/pip-wt3LBM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:25:58 INFO - Running setup.py (path:/tmp/pip-GkCAVJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:25:58 INFO - Running setup.py (path:/tmp/pip-h1mNfD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:25:58 INFO - Running setup.py (path:/tmp/pip-EhoBbi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:25:58 INFO - Running setup.py (path:/tmp/pip-kbC2QU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:25:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:25:58 INFO - Running setup.py (path:/tmp/pip-pt_gdW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:25:59 INFO - Running setup.py (path:/tmp/pip-AuWZn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:25:59 INFO - Running setup.py (path:/tmp/pip-EKrTLH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:59 INFO - Running setup.py (path:/tmp/pip-UqJOtq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:25:59 INFO - Running setup.py (path:/tmp/pip-gWSpLS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:25:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:25:59 INFO - Running setup.py (path:/tmp/pip-UMZFiY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:25:59 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 17:25:59 INFO - Running setup.py install for manifestparser 17:25:59 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 17:25:59 INFO - Running setup.py install for mozcrash 17:25:59 INFO - Running setup.py install for mozdebug 17:25:59 INFO - Running setup.py install for mozdevice 17:25:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 17:25:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 17:25:59 INFO - Running setup.py install for mozfile 17:25:59 INFO - Running setup.py install for mozhttpd 17:26:00 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozinfo 17:26:00 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozInstall 17:26:00 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozleak 17:26:00 INFO - Running setup.py install for mozlog 17:26:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for moznetwork 17:26:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozprocess 17:26:00 INFO - Running setup.py install for mozprofile 17:26:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozrunner 17:26:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 17:26:00 INFO - Running setup.py install for mozscreenshot 17:26:00 INFO - Running setup.py install for moztest 17:26:01 INFO - Running setup.py install for mozversion 17:26:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 17:26:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 17:26:01 INFO - Cleaning up... 17:26:01 INFO - Return code: 0 17:26:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:26: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 17:26: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 17:26:01 INFO - Using env: {'DISPLAY': ':0', 17:26:01 INFO - 'HOME': '/home/cltbld', 17:26:01 INFO - 'LANG': 'en_US.UTF-8', 17:26:01 INFO - 'LANGUAGE': 'en_US:en', 17:26:01 INFO - 'LOGNAME': 'cltbld', 17:26:01 INFO - 'MAIL': '/var/mail/cltbld', 17:26:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:01 INFO - 'MOZ_NO_REMOTE': '1', 17:26:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:01 INFO - 'NO_EM_RESTART': '1', 17:26:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:01 INFO - 'PWD': '/builds/slave/test', 17:26:01 INFO - 'SHELL': '/bin/bash', 17:26:01 INFO - 'SHLVL': '1', 17:26:01 INFO - 'TERM': 'linux', 17:26:01 INFO - 'TMOUT': '86400', 17:26:01 INFO - 'USER': 'cltbld', 17:26:01 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:26:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:01 INFO - '_': '/tools/buildbot/bin/python'} 17:26:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 17:26:01 INFO - Running setup.py (path:/tmp/pip-52ymKQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 17:26:01 INFO - Running setup.py (path:/tmp/pip-KFtKQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 17:26:01 INFO - Running setup.py (path:/tmp/pip-ArW1rC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 17:26:01 INFO - Running setup.py (path:/tmp/pip-NnelP9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 17:26:01 INFO - Running setup.py (path:/tmp/pip-eCa64W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 17:26:01 INFO - Running setup.py (path:/tmp/pip-590dmT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 17:26:01 INFO - Running setup.py (path:/tmp/pip-k33GHa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 17:26: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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 17:26:01 INFO - Running setup.py (path:/tmp/pip-05pfWn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 17:26:01 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)) 17:26:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 17:26:01 INFO - Running setup.py (path:/tmp/pip-5LFZNa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 17:26:02 INFO - Running setup.py (path:/tmp/pip-qshF3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 17:26:02 INFO - Running setup.py (path:/tmp/pip-U9Vyql-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 17:26:02 INFO - Running setup.py (path:/tmp/pip-1_ZdnK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 17:26:02 INFO - Running setup.py (path:/tmp/pip-z2eE3u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 17:26:02 INFO - Running setup.py (path:/tmp/pip-v9Y_zq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 17:26:02 INFO - Running setup.py (path:/tmp/pip-LhvCSy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 17:26:02 INFO - Running setup.py (path:/tmp/pip-9R2Y8Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 17:26: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)) 17:26:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 17:26:02 INFO - Running setup.py (path:/tmp/pip-1pF8KN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 17:26: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)) 17:26: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)) 17:26: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)) 17:26: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)) 17:26: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)) 17:26: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)) 17:26:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26: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 17:26:04 INFO - Downloading blessings-1.5.1.tar.gz 17:26: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 17:26:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 17:26:04 INFO - Installing collected packages: blessings 17:26:04 INFO - Running setup.py install for blessings 17:26:04 INFO - Successfully installed blessings 17:26:04 INFO - Cleaning up... 17:26:04 INFO - Return code: 0 17:26:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 17:26:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:04 INFO - Reading from file tmpfile_stdout 17:26:04 INFO - Current package versions: 17:26:04 INFO - argparse == 1.2.1 17:26:04 INFO - blessings == 1.5.1 17:26:04 INFO - blobuploader == 1.2.4 17:26:04 INFO - docopt == 0.6.1 17:26:04 INFO - manifestparser == 1.1 17:26:04 INFO - mozInstall == 1.12 17:26:04 INFO - mozcrash == 0.16 17:26:04 INFO - mozdebug == 0.1 17:26:04 INFO - mozdevice == 0.47 17:26:04 INFO - mozfile == 1.2 17:26:04 INFO - mozhttpd == 0.7 17:26:04 INFO - mozinfo == 0.9 17:26:04 INFO - mozleak == 0.1 17:26:04 INFO - mozlog == 3.1 17:26:04 INFO - moznetwork == 0.27 17:26:04 INFO - mozprocess == 0.22 17:26:04 INFO - mozprofile == 0.27 17:26:04 INFO - mozrunner == 6.11 17:26:04 INFO - mozscreenshot == 0.1 17:26:04 INFO - mozsystemmonitor == 0.0 17:26:04 INFO - moztest == 0.7 17:26:04 INFO - mozversion == 1.4 17:26:04 INFO - psutil == 3.1.1 17:26:04 INFO - requests == 1.2.3 17:26:04 INFO - wsgiref == 0.1.2 17:26:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 17:26: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')]} 17:26:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 17:26:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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')]} 17:26:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 17:26:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 17:26: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 0x7fdcf5ce9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2b916c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x2c42900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, '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': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', '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 17:26: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 17:26: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 17:26:04 INFO - Using env: {'DISPLAY': ':0', 17:26:04 INFO - 'HOME': '/home/cltbld', 17:26:04 INFO - 'LANG': 'en_US.UTF-8', 17:26:04 INFO - 'LANGUAGE': 'en_US:en', 17:26:04 INFO - 'LOGNAME': 'cltbld', 17:26:04 INFO - 'MAIL': '/var/mail/cltbld', 17:26:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:04 INFO - 'MOZ_NO_REMOTE': '1', 17:26:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:04 INFO - 'NO_EM_RESTART': '1', 17:26:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:04 INFO - 'PWD': '/builds/slave/test', 17:26:04 INFO - 'SHELL': '/bin/bash', 17:26:04 INFO - 'SHLVL': '1', 17:26:04 INFO - 'TERM': 'linux', 17:26:04 INFO - 'TMOUT': '86400', 17:26:04 INFO - 'USER': 'cltbld', 17:26:04 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:26:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:04 INFO - '_': '/tools/buildbot/bin/python'} 17:26:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 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)) 17:26:04 INFO - Cleaning up... 17:26:05 INFO - Return code: 0 17:26:05 INFO - Running post-action listener: _resource_record_post_action 17:26:05 INFO - Running post-action listener: _start_resource_monitoring 17:26:05 INFO - Starting resource monitoring. 17:26:05 INFO - ##### 17:26:05 INFO - ##### Running install step. 17:26:05 INFO - ##### 17:26:05 INFO - Running pre-action listener: _resource_record_pre_action 17:26:05 INFO - Running main action method: install 17:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 17:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 17:26:05 INFO - Reading from file tmpfile_stdout 17:26:05 INFO - Detecting whether we're running mozinstall >=1.0... 17:26:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 17:26:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 17:26:05 INFO - Reading from file tmpfile_stdout 17:26:05 INFO - Output received: 17:26:05 INFO - Usage: mozinstall [options] installer 17:26:05 INFO - Options: 17:26:05 INFO - -h, --help show this help message and exit 17:26:05 INFO - -d DEST, --destination=DEST 17:26:05 INFO - Directory to install application into. [default: 17:26:05 INFO - "/builds/slave/test"] 17:26:05 INFO - --app=APP Application being installed. [default: firefox] 17:26:05 INFO - mkdir: /builds/slave/test/build/application 17:26:05 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'] 17:26:05 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 17:26:19 INFO - Reading from file tmpfile_stdout 17:26:19 INFO - Output received: 17:26:19 INFO - /builds/slave/test/build/application/firefox/firefox 17:26:19 INFO - Running post-action listener: _resource_record_post_action 17:26:19 INFO - ##### 17:26:19 INFO - ##### Running run-tests step. 17:26:19 INFO - ##### 17:26:19 INFO - Running pre-action listener: _resource_record_pre_action 17:26:19 INFO - Running main action method: run_tests 17:26:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 17:26:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 17:26:19 INFO - Python 2.7.3 17:26:19 INFO - Return code: 0 17:26:19 INFO - grabbing minidump binary from tooltool 17:26:19 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')]} 17:26:19 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 0x2c88b70>, '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 0x2cd9dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x2cda250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 17:26:19 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 17:26:19 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 17:26:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 17:26:19 INFO - Return code: 0 17:26:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 17:26:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 17:26:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 17:26:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 17:26:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 17:26:19 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/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] in /builds/slave/test/build 17:26:19 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/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-059 --webServer localhost 17:26:19 INFO - Using env: {'DISPLAY': ':0', 17:26:19 INFO - 'HOME': '/home/cltbld', 17:26:19 INFO - 'LANG': 'en_US.UTF-8', 17:26:19 INFO - 'LANGUAGE': 'en_US:en', 17:26:19 INFO - 'LOGNAME': 'cltbld', 17:26:19 INFO - 'MAIL': '/var/mail/cltbld', 17:26:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 17:26:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 17:26:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 17:26:19 INFO - 'MOZ_NO_REMOTE': '1', 17:26:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 17:26:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 17:26:19 INFO - 'NO_EM_RESTART': '1', 17:26:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 17:26:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 17:26:19 INFO - 'PWD': '/builds/slave/test', 17:26:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 17:26:19 INFO - 'SHELL': '/bin/bash', 17:26:19 INFO - 'SHLVL': '1', 17:26:19 INFO - 'TERM': 'linux', 17:26:19 INFO - 'TMOUT': '86400', 17:26:19 INFO - 'USER': 'cltbld', 17:26:19 INFO - 'XDG_SESSION_COOKIE': '5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101', 17:26:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 17:26:19 INFO - '_': '/tools/buildbot/bin/python'} 17:26:19 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/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-059', '--webServer', 'localhost'] with output_timeout 3600 17:26:19 INFO - mozversion INFO | application_buildid: 20151123165430 17:26:19 INFO - mozversion INFO | application_changeset: c9131227ffdeee42cb1a3b4209b704e94c7bc177 17:26:19 INFO - mozversion INFO | application_display_name: Nightly 17:26:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 17:26:19 INFO - mozversion INFO | application_name: Firefox 17:26:19 INFO - mozversion INFO | application_remotingname: firefox 17:26:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 17:26:19 INFO - mozversion INFO | application_vendor: Mozilla 17:26:19 INFO - mozversion INFO | application_version: 45.0a1 17:26:19 INFO - mozversion INFO | platform_buildid: 20151123165430 17:26:19 INFO - mozversion INFO | platform_changeset: c9131227ffdeee42cb1a3b4209b704e94c7bc177 17:26:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 17:26:19 INFO - mozversion INFO | platform_version: 45.0a1 17:26:19 INFO - 2015-11-23 17:26:19,753 DEBUG : using testdate: 1448328379 17:26:19 INFO - 2015-11-23 17:26:19,753 DEBUG : actual date: 1448328379 17:26:19 INFO - 2015-11-23 17:26:19,762 INFO : starting webserver on 'localhost:52581' 17:26:19 INFO - 2015-11-23 17:26:19,763 INFO : Starting test suite talos-linux64-ix-059 17:26:19 INFO - 2015-11-23 17:26:19,763 INFO : Starting test dromaeo_css 17:26:19 INFO - 2015-11-23 17:26:19,763 DEBUG : operating with platform_type : linux_ 17:26:19 INFO - 2015-11-23 17:26:19,764 INFO : Initialising browser for dromaeo_css test... 17:26:19 INFO - 2015-11-23 17:26:19,780 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKUlNKp/profile http://localhost:52581/getInfo.html 17:26:24 INFO - 2015-11-23 17:26:24,408 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:26:24 INFO - 2015-11-23 17:26:24,408 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:26:24 INFO - 2015-11-23 17:26:24,408 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:26:24 INFO - 2015-11-23 17:26:24,408 DEBUG : BROWSER_OUTPUT: __metrics 17:26:24 INFO - 2015-11-23 17:26:24,545 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:26:25 INFO - 2015-11-23 17:26:25,702 INFO : Browser initialized. 17:26:25 INFO - 2015-11-23 17:26:25,703 INFO : Running cycle 1/1 for dromaeo_css test... 17:26:25 INFO - 2015-11-23 17:26:25,703 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpKUlNKp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:26:37 INFO - 2015-11-23 17:26:37,638 DEBUG : BROWSER_OUTPUT: RSS: Main: 141938688 17:26:37 INFO - 2015-11-23 17:26:37,639 DEBUG : BROWSER_OUTPUT: 17:27:28 INFO - 2015-11-23 17:27:28,756 DEBUG : BROWSER_OUTPUT: 1448328448755 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] 17:29:40 INFO - 2015-11-23 17:29:40,747 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52581/tests/dromaeo/cssquery-ext.html) 17:29:42 INFO - 2015-11-23 17:29:42,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 273731584 17:29:42 INFO - 2015-11-23 17:29:42,058 DEBUG : BROWSER_OUTPUT: 17:32:44 INFO - 2015-11-23 17:32:44,569 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-ext.html (next: http://localhost:52581/tests/dromaeo/cssquery-jquery.html) 17:32:45 INFO - 2015-11-23 17:32:45,138 DEBUG : BROWSER_OUTPUT: RSS: Main: 214343680 17:32:45 INFO - 2015-11-23 17:32:45,138 DEBUG : BROWSER_OUTPUT: 17:35:47 INFO - 2015-11-23 17:35:47,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52581/tests/dromaeo/cssquery-mootools.html) 17:35:47 INFO - 2015-11-23 17:35:47,667 DEBUG : BROWSER_OUTPUT: RSS: Main: 226725888 17:35:47 INFO - 2015-11-23 17:35:47,667 DEBUG : BROWSER_OUTPUT: 17:38:49 INFO - 2015-11-23 17:38:49,581 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52581/tests/dromaeo/cssquery-prototype.html) 17:38:50 INFO - 2015-11-23 17:38:50,167 DEBUG : BROWSER_OUTPUT: RSS: Main: 205729792 17:38:50 INFO - 2015-11-23 17:38:50,167 DEBUG : BROWSER_OUTPUT: 17:41:52 INFO - 2015-11-23 17:41:52,956 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52581/tests/dromaeo/cssquery-yui.html) 17:41:53 INFO - 2015-11-23 17:41:53,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 206671872 17:41:53 INFO - 2015-11-23 17:41:53,562 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/dromaeo/cssquery-yui.html (next: http://localhost:52581/tests/dromaeo/cssquery-dojo.html) 17:44:56 INFO - 2015-11-23 17:44:56,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 251338752 17:44:56 INFO - 2015-11-23 17:44:56,280 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,280 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:44:56 INFO - 2015-11-23 17:44:56,280 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:44:56 INFO - 2015-11-23 17:44:56,281 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:44:56 INFO - 2015-11-23 17:44:56,281 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:44:56 INFO - 2015-11-23 17:44:56,281 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2622.409957759504;2702.4324891772726;2711.6068170115323;2723.319170207448;2746.052611848913;4566.04113136241;4658.27796691513;4664.580187783103;4692.859214223575;4697.85906422807;4604.171249175147;4614.192516309649;4697.812087516495;4703.318018887259;4720.268358404444;4304.268274393361;4313.676474264443;4319.654427645781;4326.264535029037;4335.458067741532;4160.750354978711;4370.956290437102;4383.211022016036;4413.139437809628;4414.249577571804;4220.873373798791;4298.828046878121;4307.849225277131;4312.504062032859;4324.091940692459;4339.392485052095;4352.695311328208;4359.629431498326;4363.367311739812;4414.823407063745;4329.350597410382;4339.305711086211;4342.50061242958;4362.956370436286;4392.472903251598;4460.107978404332;4594.816207351702;4620.745858977755;4622.976885115553;4716.693414928019;4946.480619534969;4954.777035033396;4962.727050012248;4963.950360496421;4967.50324967504;4983.277424773424;4984.401871775374;4987.152184128707;4987.177115775893;4987.226979818134;4514.616257618107;4616.76916154191;4639.605633521121;4640.327152562893;4718.528147185322;5151.072806894795;5183.481651834786;5190.455002224712;5199.636025478256;5230.947690523122;4974.552290293891;4982.975085124624;4984.825531106394;4986.90026199474;5035.1188542005;4856.344393506902;4920.4095508538485;4970.826021089245;4976.850694479172;5023.547880690682;4997.85006449807;4997.925031124536;5004.474530174352;5007.298978143063;5057.468965758616;4965.875853103701;4967.105920934267;4975.601951843843;4978.601711863114;5015.648904576645;4022.718409711292;4070.898227544276;4110.609492098306;4110.958890411118;4113.691473139526;3652.342578335925;3702.1485058436174;3708.2583483302906;3710.8330125144435;3716.9814150929615;4282.293421585466;4336.241157797373;4338.240807858612;4375;4381.539938306496;5003.449620541737;5038.345015148007;5073.720945348041;5078.542931136216;5120.564751996122;4183.832646694098;4290.120525292307;4293.0769884474985;4377.802998865059;4406.669499787528;4399.450068741407;4442.511323754385;4474.865754027384;4491.30384790358;4523.434570678665;4776.068666610047;4803.687760295569;4812.374391329175;4816.494268101799;4820.469748327611;4829.830955916526;4895.902081958412;5072.061668591175;5076.593872490266;5105.591552675852;4631.6757826953135;4695.483496815279;4702.576768090888;4732.408448943882;4759.143354196278;4940.950590494049;4964.205727083649;4966.751662416937;4972.975135124301;5009.724465154306;5040.16837221869;5047.444781074006;5048.318477005557;5052.5705315048635;5093.796248150033;4690.15577196108;4749.145153872198;4790.449098353594;4796.088743138793;4864.343313652753;4880.853574392774;4907.60739140875;4907.60739140875;4960.255961605788;4960.677555958851;4783.899703068383;4796.784144713426;4796.784144713566;4804.351412559399;4827.831025914076;4748.453927798348;4861.246506791453;4862.562369386772;4863.076015557032;4868.3427737255015;4671.929921051119;4731.148393289241;4816.8073277069925;4835.758212089311;4853.102176097434 17:44:56 INFO - 2015-11-23 17:44:56,281 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.5425842292472;548.9011977843986;576.976920923163;578.4533615733131;581.3459857660132;27973.160805175827;28718.712812871865;37160.62839371602;37400.43899341505;37512.062198445055;40808.38787418183;41480.58519414805;41501.58498415015;41547;41557.16885662285;6964.512484126113;7897.6840926362875;8064.516129032248;8065.919340806605;8066.516009039477;7035.437165026811;7121.821954451154;7135.785926422215;7143.071400717899;10240.180785537139;10076.647317343895;10170.491475426235;10188.796224075513;10196.592136314575;10196.592136314575;10046.598136074548;10157.238207134495;10161.136303414218;10168.237382196328;10171.4914254287;6971.6862741176765;7138.857222855566;9958.601655933753;10100.242481813893;10359.171266298677;35510.467342989876;35511.64488355135;35556.28887422263;35569.82215088934;35813.82093089544;2786.317352248692;2788.7629551487944;2869.1679412970216;2960.86676099576;3481.2863363010524;27326.5901011485;27614.309642259104;27901.235801771934;27985.58021629677;28316.85841570779;3324.966750332514;3387.6781705738163;3424.3493736190294;3469.167399824024;3490.336836001177;225237;226325;226481;226668;227114;55319.72340138354;55897.44102558922;55982.720086399306;55991;56014.71992640011;60105;60167;60382.39617603856;60470;60470.697646511486;12446.128770986124;12698.682532936751;12756.107072505021;12779.361031948365;12799.296038717774;10116.898831011596;10163.085322321027;10185.236107291983;10189.388636681822;10208.591656333812;19059.856408615527;19406.92500807846;19466.011922845115;19483.769341202868;19538.413847584594;7610.39116870649;7738.961305193438;7786.260305271104;7793.961030194812;7971.800704982422;790.7311514085238;795.3319211861948;827.8261565071402;873.0963452826421;886.2201262888617;26148.60777088307;26198.08306709256;26238.86880565585;26526.336841579116;26568.867155664484;886.7916039730658;901.693424235763;923.5243849417556;950.396498223633;960.6685693435753;13773.173609583457;13982.930085349508;14044.578662640137;14272.643183920485;14277.571672849832;571886;577238;578793;592771;594261;49373.75313123483;49734.50265497299;50019;50023.49976500261;50029.249561255885;1175.9412029398668;1191.8450601421932;1194.5580135350149;1201.9579314723942;1207.2394391533278;27715.584266236427;28745.712542874302;28926.566101508073;29032.56451153192;29203.415931681673;42138.57861421347;43130.1373972525;43135.784321078194;43147;43169.13661726811;248838;250427;250851;250897;251126;34118.488222676184;35472.29055418929;36132.63867361293;40253.39619905762;40888;37266.62733372632;37350.43974340333;37395.43906841345;37418.251634967695;37517.24965500729;29897.402051959274;30181;34988.47517287192;35212.82393588016;38111.42832857454;30711.846440768546;34007.82996085004;34400;34541.65005978457;34757.47863781995;34622.65377346295;34964.47553286652;34992;35004.82497587496;35110;27560.862195688893;30854.53718194184;31679;31728.524072139397;31744.206394840312;23876.40308992289;24370.634440483052;24448.633270500603;25097.24708258755;25391.87304063542 17:44:56 INFO - 2015-11-23 17:44:56,282 DEBUG : BROWSER_OUTPUT: |2;jquery.html;329.0867841739175;332.17123277422826;332.3187465695324;333.5397151930337;336.89387842829524;11696.473658685358;12176.269423834576;14574;15054.172020538866;15917.52247432576;11836.940815295911;14575.489857854976;14713.264336783172;14808.111513309183;14860.405583776663;4880.8047678092835;4887.902241955158;5020.246962955568;5034.697918124906;5054.039732450822;3328.034869887742;3416.4533674612067;4998.900021999558;5022.648414610979;6408.871822563546;6471.061696054069;6510.739570417178;6598.274189839138;6621;6622.370874766913;6452.516061295421;6501.349865013508;6536.738530458776;6544.149260596139;6554.27902930682;6084.452399284086;6261.530385221081;6277.403646653606;6290.056491526262;6302.747890084391;20242.5951480971;20482.18071277147;20769.89615051915;20975.79024209769;21010.894945525328;1866.9813301866943;1896.5922326699688;1916.568772026297;1924.7594050743658;1966.6853303471376;13134.408951597201;13838.584842454642;14026.228557429336;14128.858711412857;14312.998090133695;1798.1638538079726;1811.4927820210362;1855.85153187746;1888.745019422374;1900.1734245603207;59135;63086;63763;63972.36027639711;64657.67671161661;15276.770848437282;15308;15351.385944562317;15392.384304627913;15413.075215487106;23123.53752924932;23162.768372316063;23436.882815585814;23477.882610587178;23498.47522871583;7483.70065197386;7535.7362492313605;7561.924380756122;7566.924330756732;7585.1656317805;6073.362296958844;6193.071039344134;6202.379762023852;6446.484281257488;6471.708773105222;7549.320561149523;7557.773266802004;7590.013298271189;7649.349805266615;7667;1683.545442730456;1747.6155245845894;1751.9036452995208;1771.76081229035;2004.8772687295161;828.8963879515061;888.9155530224618;912.9634814607474;937.5031233446284;966.1835748792225;12802.295873727035;14086.295685215699;14976.62558436026;15062.849371506363;15396.307166177548;789.4907784478979;808.2967817998261;835.8286551256978;854.3677678517977;910.1080940678172;8345.791355216046;8614.396992210484;8634.5251011195;8776.736697899074;8851.07063758309;441815;472747;498688;500819;500929;68253;68354.65822670855;68686.31313686799;68713.65643171853;69162.65418672975;998.6554638649654;1013.5135135135176;1044.185535282481;1057.7778666479971;1059.9788004239872;13775.86224137786;13795;13834.896978946945;14243.715125697636;14331.211783352015;32415.027549173563;32753.50869736908;33253.667463326026;33571.83214083914;33744;41763.37354939617;42426.363604546576;43273.35089973716;44007;45659;8554.91445085541;8740.257078148174;8804.64781408762;8816.51509167002;8847.247983921181;15237.3905043797;15427.69144617079;15751.291191896622;16148.67702645917;16237.918810405872;13454.125481843648;13541.255230962392;13639.931800340935;13645.385957632128;13995.790063149265;13092.214467132002;13192.406341714453;13280.933595331962;13520.59438216855;13634.250116243702;13308.40112194973;13464.528741494001;13569.457221711022;13887.375068121757;14059.367328470447;8572;8605.870911936452;8721.258693011165;8728.127187281221;8771.298296136167;9336;9465.242780577675;11868.821967670665;13335.933320333725;13637.659058523615 17:44:56 INFO - 2015-11-23 17:44:56,285 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1394.0381137015465;1575.4013474879546;1616.070759313395;1641.967160656787;1647.9258433370496;5848.619839710416;6136.785212517563;6504.252011018734;6648.301928297519;6651.401373876351;6752.122224110859;6792.898106528393;6793.388595026447;6798.388145066943;6813.386795188432;1735.878488505805;1770.1060964213118;2023.6660950943076;2041.4896275931017;2045.263705066175;1981.4749091490767;2024.3623258673545;2025.1899240303849;2026.8581199316054;2028.452317874173;2016.5966806638658;2017.273781438681;2026.4528577284125;2077.0549400022956;2080.43828166395;2022.7471566054244;2035.4504283843353;2057.886816225107;2062.257587268582;2063.329417939176;1991.6415045291842;2017.7175195472646;2019.717239586459;2020.7373041504657;2021.777604463508;6519.119918810948;6563.868722625569;6568.343165683394;6571.080048793173;6571.112899758519;3897.883063508071;3942.9605703943166;3952.980235098806;3964.781936993464;3972.1459886124335;2556.5653838847443;2603.0889188783963;2633.3548280671166;2646.827956182842;2665.693445253801;737.329030582173;849.2696281198165;851.7870532366908;869.1091631078132;874.9518776467291;8823.205911467934;8857.158569935782;8862.689805856828;8934.195922367018;8937.329700272505;3807.505024346817;3822.885313440546;3828.0238539172888;3833.674137698327;3843.6925045996254;7786.649600767979;7790.5325680459355;7800.375969922393;7802.102758182768;7827.921720782833;4023.3562629979065;4044.9595504045174;4052.3516237401873;4054.918901621951;4056.7971601419813;3643.2713457308646;3650.3611867923537;3653.8538458461894;3656.3784156693428;3659.8902032939054;3264.771465997357;3280.5407242986003;3302.78531895426;3314.270860410754;3337.1490269981487;1031.3296357367772;1044.6761503933806;1050.033968748753;1053.4574694032578;1057.5293994172673;854.1757204297758;871.5424402188775;872.8559787635096;889.226373055446;1131.6661584832493;6437.678116094176;6450.096986421905;6467.676616169173;6476.870462590816;6477.514186436036;415.93968874513024;418.32440608417187;433.9002029533225;439.2510769138611;441.8630224630311;5052.8484145475695;5106.157484015096;5142.51146141116;5143.7685304161405;5145.536901678867;7105.573665579978;8009.7997550060545;8010.198980101944;8084.39367047462;8086.797830054295;7224.0608720867;7683.692652293846;7952.3638108951145;8010.959945200237;8028.638711258008;6232.376762323732;6310.4636105930595;6339.96830015847;6387.776427825004;6394.552381333262;6212.565120441706;6413.230412350548;6426.485881129592;6427.132337134614;6438.581492202992;7090.220075791555;7284.890726639211;7291.30732580404;7335.963320183579;7344.118705755343;7321.853562928818;7423.554586724814;7468.775936721907;7474.327310542078;7574.128975167926;5826;5845.970770146292;5877.882442351214;5886.381929897299;5893.233879595625;6232.906506402317;6249.750009999549;6283.654399007915;6298.1812364392335;6299.874002519832;6141.877162456636;6176;6181.53638477125;6278.246610406598;6317.399847014526;6148.877022459616;6186.381361863778;6190.969045154926;6240.313565507699;6287.434130928238;6044.24446944132;6076;6090;6093.786717465045;6094.786682466092;5456.317960254968;5558.888822223452;5591.189277554813;5598.188262701804;5823.126531020212;5908.3205431375945;5935.584509084495;5949.613275137275;5954.166416701752;5958.523318134626 17:44:56 INFO - 2015-11-23 17:44:56,285 DEBUG : BROWSER_OUTPUT: |4;prototype.html;306.20845115376756;313.5030975903193;318.05854670176285;318.9489681650936;319.0524143294415;5212.8696782580455;5252.290940723006;5412.404635490093;5480.26016487774;5519.39286678465;5143.897122057557;5311.867203319919;5319.20211968205;5321.308229930113;5357.571394288448;3916.314644937139;4008.33862412703;4134.813933373005;4149.854755083573;4154.563770804068;4011.117554138085;4019.6985226108013;4072.796360181994;4091.856785012525;4097.651699605537;4031.052702614883;4066.755994640316;4094.75431474111;4098.4876890388705;4100.528439229482;4083.509978802533;4094.7747873866924;4095.8361665533344;4096.610821971908;4102.2821006323775;3602.2435288589168;3602.9099272518133;3607.3867442534834;3608.7654302470255;3613.981930090359;5021.472745361721;5127.435982041972;5139.768710408003;5142.640015198937;5145.742712864342;4737.076270127326;4740.525947405266;4745.477997420281;4747.620190384761;4748.264019077049;5323.920141197885;5590.832275031715;5592.972035139839;5602.439756024406;5605.5515558755205;3803.2773772983323;3817.9618203817886;3912.256671232457;3915.11909820291;3915.843366265346;5785.103308987113;5911.261092363455;5913.8817223655715;5915.438033386865;5917.704114794286;4015.3976903464713;4017.77902215381;4020.075382662004;4023.5574086850424;4024.2555127301544;3993.72043956926;4069.409935559327;4074.3277359235985;4086.7752273625238;4093.4473846031;4683.367745354333;4690.906181876343;4692.460367057832;4692.7653617319;4699.412573428322;5581.2186293918885;5613.803516876889;5628.831135065872;5630.296212973379;5634.1830434586755;1439.863212994764;1460.8466111058185;1464.2751837840124;1464.4654701034258;1465.3991863335982;971.9222462203007;971.9416834989923;987.1017374189453;1004.0561871840447;1004.4073996342194;5000.874978125576;5007.148784706608;5008;5010.799568017312;5011.599072074226;5868.501177399969;5873.471387575139;5874.060150375919;5880.14737863016;5889.440503152194;4999.875003124951;5006.349174607278;5006.6495345325475;5007.273945277914;5009;3083.892063777757;3146.65386807451;3164.984175079156;3171.0962375722806;3172.0642410488963;5536.197251398606;5548.667079975215;5551.195076713854;5556.944430555724;5557.194206839986;5974.940250597525;5977.611455255482;5982.371850955674;5994.550408719363;5998.670073145931;5408.9459105410015;5533.972330138404;5541.27963364768;5546.112621980464;5556.416576259516;5815.273090863642;5859.384764599656;5860.2967643883;5865.266841644794;5871.706414679164;5520.089185284543;5673.858153546029;5676.120201368794;5682.857928551819;5691.430856914441;5436.483534064258;5524.14375771756;5544.63959842609;5621.353544342453;5634.408387119293;4118.52636946755;4120.25835349628;4120.546739858553;4124.7731374773475;4129.442525259172;5771.076627739541;5901.734421951109;5909.6158749681135;5914;5931.110333449845;5716.771329146954;5719.857003574777;5721.885562288648;5725.971370143123;5726.656400615976;5702.230198923092;5713.05734553794;5714.3999880012;5717.7141142941855;5718.228039214653;5357.78568857257;5520.66875987442;5544.69504177258;5556.361018482765;5563.944360556505;5750.568707346882;5754.913676294943;5763.703166787439;5765.077587585966;5765.308163020464;5620.831375058755;5625.803096891589;5627.268455100811;5629.746661400165;5630.127330263816 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: |5;yui.html;745.5675708089309;746.1009483572294;752.713968691897;754.3399525415261;764.8546776112538;11250.943745281273;11503.654890353293;11545.653630391082;11607.187496875222;11619.419029048546;10281.691549253534;11439.313641181536;11524.366159861203;11528.71178220545;11538.769224615502;741.2624438683517;753.8416932444193;754.9471536992413;756.6292516666849;757.1860250230997;751.7143485475511;759.7948553890446;759.8138456078268;760.1182628151346;760.2739383888373;789.5775759968418;797.0873350014231;797.1470526536608;797.3262593108814;797.9785874081185;793.4089103617813;795.3319211862034;795.3517882925427;795.9482633628795;796.1560745609614;587.1867463562996;587.6855882103055;588.0385569593702;588.3763210996358;588.5409380683074;11474;11476.4835582399;11606.593769218121;11610.24533405326;11630.76738465226;10820.621278255223;10983.61557345489;11153.66539003823;11221.326720396803;11604.6518604442;8525.872111918326;8612;8701.260392866614;8717.956410217972;8770.956145219297;3255.283837555734;3299.9175020624434;3300.85146168423;3303.702666759979;3305.388503126929;39265;40429.19141617151;40852.18295634101;40907.18185636271;40967.795161024005;8731.781705457415;8811.471311721318;8840.690575829814;8874.068222836639;8947.955260223787;15481.767773483407;15504.612384690474;15529.223538823013;15646.530604081896;15662.921685391728;6181.876362472725;6226.782062627877;6276.309605943343;6332.176817013851;6407.038944158414;3504.229069604683;3518.876839310663;3520;3552.378333791576;3563.768355056965;2574.9871250643628;2594.4551644154562;2604.2577865308294;2611.9552179128123;2613.372790530259;470.348567234376;475.529226066192;475.7716296177785;485.9951400486021;493.4251596889655;380.2755750295691;396.2016536678595;434.7782630858222;509.76041260607457;533.4212379568135;7223.422126229889;7226.024486694334;7321.304476074764;7671.079470463468;7704.807379815549;431.3034449364317;492.8669259299969;517.891242839008;529.2881074954181;550.4770468055364;3465.4801779733243;3503.1242189452637;3515.33208690348;3546.113471632092;3766.60450652683;42768.78615606964;42778.35832462516;42947;42975.570244297785;43067.13865722668;40088.39867401991;40558.39162412566;40588.79705601453;41266.79366603148;45000.77499612481;41961;42432.99999999938;42587.57412425836;42647;42962.78518607387;7597.392208623186;7748.302652761278;7781.338586220235;8063.27430531255;8152.429329946846;25792.09727659523;27011.864940675958;27468.313292167855;30640.84679576588;31794.205144871565;36985.44521832228;37173;37452;37826.810865945496;37938.62061379351;9020.368574199743;9228.723138305862;9414.62341506332;9657.951710241405;9690.961057520408;10327.586896524355;10804.945975270388;10848.67453976382;11024.724381890517;11103.833442498531;9612.66355677548;9734.513274336114;9779.80440391174;9968.601255949681;10160.441175735405;9110.590023448829;9158.542072896194;9161.7866176929;9192.264618830344;9365.157135857806;9017.954910225408;9264.21254193374;9476.336656433983;9928.553215105481;10224.539895704562;8407.2433480987;8476.872846907178;8544.487330759926;8577.399582029198;8735.344849136467;8172.713955011784;8403.83192336162;8516.74449766508;8531.317494600293;8784.956075219583 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1131 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: __startTimestamp1448329496274__endTimestamp 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,289 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: Number of tests: 6 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4625.21 Median:4748.45 stddev:478.88 (10.1%) stddev-sans-first:453.84 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: Values: 2622.4 2702.4 2711.6 2723.3 2746.1 4566.0 4658.3 4664.6 4692.9 4697.9 4604.2 4614.2 4697.8 4703.3 4720.3 4304.3 4313.7 4319.7 4326.3 4335.5 4160.8 4371.0 4383.2 4413.1 4414.2 4220.9 4298.8 4307.8 4312.5 4324.1 4339.4 4352.7 4359.6 4363.4 4414.8 4329.4 4339.3 4342.5 4363.0 4392.5 4460.1 4594.8 4620.7 4623.0 4716.7 4946.5 4954.8 4962.7 4964.0 4967.5 4983.3 4984.4 4987.2 4987.2 4987.2 4514.6 4616.8 4639.6 4640.3 4718.5 5151.1 5183.5 5190.5 5199.6 5230.9 4974.6 4983.0 4984.8 4986.9 5035.1 4856.3 4920.4 4970.8 4976.9 5023.5 4997.9 4997.9 5004.5 5007.3 5057.5 4965.9 4967.1 4975.6 4978.6 5015.6 4022.7 4070.9 4110.6 4111.0 4113.7 3652.3 3702.1 3708.3 3710.8 3717.0 4282.3 4336.2 4338.2 4375.0 4381.5 5003.4 5038.3 5073.7 5078.5 5120.6 4183.8 4290.1 4293.1 4377.8 4406.7 4399.5 4442.5 4474.9 4491.3 4523.4 4776.1 4803.7 4812.4 4816.5 4820.5 4829.8 4895.9 5072.1 5076.6 5105.6 4631.7 4695.5 4702.6 4732.4 4759.1 4941.0 4964.2 4966.8 4973.0 5009.7 5040.2 5047.4 5048.3 5052.6 5093.8 4690.2 4749.1 4790.4 4796.1 4864.3 4880.9 4907.6 4907.6 4960.3 4960.7 4783.9 4796.8 4796.8 4804.4 4827.8 4748.5 4861.2 4862.6 4863.1 4868.3 4671.9 4731.1 4816.8 4835.8 4853.1 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,290 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:50376.02 Median:19113.32 stddev:104274.69 (545.6%) stddev-sans-first:104500.09 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: Values: 544.5 548.9 577.0 578.5 581.3 27973.2 28718.7 37160.6 37400.4 37512.1 40808.4 41480.6 41501.6 41547.0 41557.2 6964.5 7897.7 8064.5 8065.9 8066.5 7035.4 7121.8 7135.8 7143.1 10240.2 10076.6 10170.5 10188.8 10196.6 10196.6 10046.6 10157.2 10161.1 10168.2 10171.5 6971.7 7138.9 9958.6 10100.2 10359.2 35510.5 35511.6 35556.3 35569.8 35813.8 2786.3 2788.8 2869.2 2960.9 3481.3 27326.6 27614.3 27901.2 27985.6 28316.9 3325.0 3387.7 3424.3 3469.2 3490.3 225237.0 226325.0 226481.0 226668.0 227114.0 55319.7 55897.4 55982.7 55991.0 56014.7 60105.0 60167.0 60382.4 60470.0 60470.7 12446.1 12698.7 12756.1 12779.4 12799.3 10116.9 10163.1 10185.2 10189.4 10208.6 19059.9 19406.9 19466.0 19483.8 19538.4 7610.4 7739.0 7786.3 7794.0 7971.8 790.7 795.3 827.8 873.1 886.2 26148.6 26198.1 26238.9 26526.3 26568.9 886.8 901.7 923.5 950.4 960.7 13773.2 13982.9 14044.6 14272.6 14277.6 571886.0 577238.0 578793.0 592771.0 594261.0 49373.8 49734.5 50019.0 50023.5 50029.2 1175.9 1191.8 1194.6 1202.0 1207.2 27715.6 28745.7 28926.6 29032.6 29203.4 42138.6 43130.1 43135.8 43147.0 43169.1 248838.0 250427.0 250851.0 250897.0 251126.0 34118.5 35472.3 36132.6 40253.4 40888.0 37266.6 37350.4 37395.4 37418.3 37517.2 29897.4 30181.0 34988.5 35212.8 38111.4 30711.8 34007.8 34400.0 34541.7 34757.5 34622.7 34964.5 34992.0 35004.8 35110.0 27560.9 30854.5 31679.0 31728.5 31744.2 23876.4 24370.6 24448.6 25097.2 25391.9 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27054.55 Median:16954.36 stddev:78896.64 (465.3%) stddev-sans-first:79092.45 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: Values: 329.1 332.2 332.3 333.5 336.9 11696.5 12176.3 14574.0 15054.2 15917.5 11836.9 14575.5 14713.3 14808.1 14860.4 4880.8 4887.9 5020.2 5034.7 5054.0 3328.0 3416.5 4998.9 5022.6 6408.9 6471.1 6510.7 6598.3 6621.0 6622.4 6452.5 6501.3 6536.7 6544.1 6554.3 6084.5 6261.5 6277.4 6290.1 6302.7 20242.6 20482.2 20769.9 20975.8 21010.9 1867.0 1896.6 1916.6 1924.8 1966.7 13134.4 13838.6 14026.2 14128.9 14313.0 1798.2 1811.5 1855.9 1888.7 1900.2 59135.0 63086.0 63763.0 63972.4 64657.7 15276.8 15308.0 15351.4 15392.4 15413.1 23123.5 23162.8 23436.9 23477.9 23498.5 7483.7 7535.7 7561.9 7566.9 7585.2 6073.4 6193.1 6202.4 6446.5 6471.7 7549.3 7557.8 7590.0 7649.3 7667.0 1683.5 1747.6 1751.9 1771.8 2004.9 828.9 888.9 913.0 937.5 966.2 12802.3 14086.3 14976.6 15062.8 15396.3 789.5 808.3 835.8 854.4 910.1 8345.8 8614.4 8634.5 8776.7 8851.1 441815.0 472747.0 498688.0 500819.0 500929.0 68253.0 68354.7 68686.3 68713.7 69162.7 998.7 1013.5 1044.2 1057.8 1060.0 13775.9 13795.0 13834.9 14243.7 14331.2 32415.0 32753.5 33253.7 33571.8 33744.0 41763.4 42426.4 43273.4 44007.0 45659.0 8554.9 8740.3 8804.6 8816.5 8847.2 15237.4 15427.7 15751.3 16148.7 16237.9 13454.1 13541.3 13639.9 13645.4 13995.8 13092.2 13192.4 13280.9 13520.6 13634.3 13308.4 13464.5 13569.5 13887.4 14059.4 8572.0 8605.9 8721.3 8728.1 8771.3 9336.0 9465.2 11868.8 13335.9 13637.7 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4708.25 Median:5956.34 stddev:2416.81 (40.6%) stddev-sans-first:2410.75 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: Values: 1394.0 1575.4 1616.1 1642.0 1647.9 5848.6 6136.8 6504.3 6648.3 6651.4 6752.1 6792.9 6793.4 6798.4 6813.4 1735.9 1770.1 2023.7 2041.5 2045.3 1981.5 2024.4 2025.2 2026.9 2028.5 2016.6 2017.3 2026.5 2077.1 2080.4 2022.7 2035.5 2057.9 2062.3 2063.3 1991.6 2017.7 2019.7 2020.7 2021.8 6519.1 6563.9 6568.3 6571.1 6571.1 3897.9 3943.0 3953.0 3964.8 3972.1 2556.6 2603.1 2633.4 2646.8 2665.7 737.3 849.3 851.8 869.1 875.0 8823.2 8857.2 8862.7 8934.2 8937.3 3807.5 3822.9 3828.0 3833.7 3843.7 7786.6 7790.5 7800.4 7802.1 7827.9 4023.4 4045.0 4052.4 4054.9 4056.8 3643.3 3650.4 3653.9 3656.4 3659.9 3264.8 3280.5 3302.8 3314.3 3337.1 1031.3 1044.7 1050.0 1053.5 1057.5 854.2 871.5 872.9 889.2 1131.7 6437.7 6450.1 6467.7 6476.9 6477.5 415.9 418.3 433.9 439.3 441.9 5052.8 5106.2 5142.5 5143.8 5145.5 7105.6 8009.8 8010.2 8084.4 8086.8 7224.1 7683.7 7952.4 8011.0 8028.6 6232.4 6310.5 6340.0 6387.8 6394.6 6212.6 6413.2 6426.5 6427.1 6438.6 7090.2 7284.9 7291.3 7336.0 7344.1 7321.9 7423.6 7468.8 7474.3 7574.1 5826.0 5846.0 5877.9 5886.4 5893.2 6232.9 6249.8 6283.7 6298.2 6299.9 6141.9 6176.0 6181.5 6278.2 6317.4 6148.9 6186.4 6191.0 6240.3 6287.4 6044.2 6076.0 6090.0 6093.8 6094.8 5456.3 5558.9 5591.2 5598.2 5823.1 5908.3 5935.6 5949.6 5954.2 5958.5 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4677.29 Median:5315.53 stddev:1380.74 (26.0%) stddev-sans-first:1345.07 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: Values: 306.2 313.5 318.1 318.9 319.1 5212.9 5252.3 5412.4 5480.3 5519.4 5143.9 5311.9 5319.2 5321.3 5357.6 3916.3 4008.3 4134.8 4149.9 4154.6 4011.1 4019.7 4072.8 4091.9 4097.7 4031.1 4066.8 4094.8 4098.5 4100.5 4083.5 4094.8 4095.8 4096.6 4102.3 3602.2 3602.9 3607.4 3608.8 3614.0 5021.5 5127.4 5139.8 5142.6 5145.7 4737.1 4740.5 4745.5 4747.6 4748.3 5323.9 5590.8 5593.0 5602.4 5605.6 3803.3 3818.0 3912.3 3915.1 3915.8 5785.1 5911.3 5913.9 5915.4 5917.7 4015.4 4017.8 4020.1 4023.6 4024.3 3993.7 4069.4 4074.3 4086.8 4093.4 4683.4 4690.9 4692.5 4692.8 4699.4 5581.2 5613.8 5628.8 5630.3 5634.2 1439.9 1460.8 1464.3 1464.5 1465.4 971.9 971.9 987.1 1004.1 1004.4 5000.9 5007.1 5008.0 5010.8 5011.6 5868.5 5873.5 5874.1 5880.1 5889.4 4999.9 5006.3 5006.6 5007.3 5009.0 3083.9 3146.7 3165.0 3171.1 3172.1 5536.2 5548.7 5551.2 5556.9 5557.2 5974.9 5977.6 5982.4 5994.6 5998.7 5408.9 5534.0 5541.3 5546.1 5556.4 5815.3 5859.4 5860.3 5865.3 5871.7 5520.1 5673.9 5676.1 5682.9 5691.4 5436.5 5524.1 5544.6 5621.4 5634.4 4118.5 4120.3 4120.5 4124.8 4129.4 5771.1 5901.7 5909.6 5914.0 5931.1 5716.8 5719.9 5721.9 5726.0 5726.7 5702.2 5713.1 5714.4 5717.7 5718.2 5357.8 5520.7 5544.7 5556.4 5563.9 5750.6 5754.9 5763.7 5765.1 5765.3 5620.8 5625.8 5627.3 5629.7 5630.1 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,291 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11619.84 Median:493.15 stddev:13073.24 (2651.0%) stddev-sans-first:13084.40 17:44:56 INFO - 2015-11-23 17:44:56,292 DEBUG : BROWSER_OUTPUT: Values: 745.6 746.1 752.7 754.3 764.9 11250.9 11503.7 11545.7 11607.2 11619.4 10281.7 11439.3 11524.4 11528.7 11538.8 741.3 753.8 754.9 756.6 757.2 751.7 759.8 759.8 760.1 760.3 789.6 797.1 797.1 797.3 798.0 793.4 795.3 795.4 795.9 796.2 587.2 587.7 588.0 588.4 588.5 11474.0 11476.5 11606.6 11610.2 11630.8 10820.6 10983.6 11153.7 11221.3 11604.7 8525.9 8612.0 8701.3 8718.0 8771.0 3255.3 3299.9 3300.9 3303.7 3305.4 39265.0 40429.2 40852.2 40907.2 40967.8 8731.8 8811.5 8840.7 8874.1 8948.0 15481.8 15504.6 15529.2 15646.5 15662.9 6181.9 6226.8 6276.3 6332.2 6407.0 3504.2 3518.9 3520.0 3552.4 3563.8 2575.0 2594.5 2604.3 2612.0 2613.4 470.3 475.5 475.8 486.0 493.4 380.3 396.2 434.8 509.8 533.4 7223.4 7226.0 7321.3 7671.1 7704.8 431.3 492.9 517.9 529.3 550.5 3465.5 3503.1 3515.3 3546.1 3766.6 42768.8 42778.4 42947.0 42975.6 43067.1 40088.4 40558.4 40588.8 41266.8 45000.8 41961.0 42433.0 42587.6 42647.0 42962.8 7597.4 7748.3 7781.3 8063.3 8152.4 25792.1 27011.9 27468.3 30640.8 31794.2 36985.4 37173.0 37452.0 37826.8 37938.6 9020.4 9228.7 9414.6 9658.0 9691.0 10327.6 10804.9 10848.7 11024.7 11103.8 9612.7 9734.5 9779.8 9968.6 10160.4 9110.6 9158.5 9161.8 9192.3 9365.2 9018.0 9264.2 9476.3 9928.6 10224.5 8407.2 8476.9 8544.5 8577.4 8735.3 8172.7 8403.8 8516.7 8531.3 8785.0 17:44:56 INFO - 2015-11-23 17:44:56,292 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:44:56 INFO - 2015-11-23 17:44:56,292 DEBUG : BROWSER_OUTPUT: 17:44:56 INFO - 2015-11-23 17:44:56,991 INFO : Browser exited with error code: 0 17:44:57 INFO - 2015-11-23 17:44:57,014 INFO : Completed test dromaeo_css (00:18:37) 17:44:57 INFO - 2015-11-23 17:44:57,014 INFO : Starting test kraken 17:44:57 INFO - 2015-11-23 17:44:57,015 DEBUG : operating with platform_type : linux_ 17:44:57 INFO - 2015-11-23 17:44:57,015 INFO : Initialising browser for kraken test... 17:44:57 INFO - 2015-11-23 17:44:57,021 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqle3mI/profile http://localhost:52581/getInfo.html 17:45:00 INFO - 2015-11-23 17:45:00,833 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:45:00 INFO - 2015-11-23 17:45:00,833 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:45:00 INFO - 2015-11-23 17:45:00,834 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:45:00 INFO - 2015-11-23 17:45:00,834 DEBUG : BROWSER_OUTPUT: __metrics 17:45:00 INFO - 2015-11-23 17:45:00,930 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:45:02 INFO - 2015-11-23 17:45:02,139 INFO : Browser initialized. 17:45:02 INFO - 2015-11-23 17:45:02,140 INFO : Running cycle 1/1 for kraken test... 17:45:02 INFO - 2015-11-23 17:45:02,140 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpqle3mI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:45:14 INFO - 2015-11-23 17:45:14,044 DEBUG : BROWSER_OUTPUT: RSS: Main: 140713984 17:45:14 INFO - 2015-11-23 17:45:14,045 DEBUG : BROWSER_OUTPUT: 17:45:16 INFO - 2015-11-23 17:45:16,685 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52581/tests/kraken/driver.html?testName=audio-beat-detection) 17:45:17 INFO - 2015-11-23 17:45:17,268 DEBUG : BROWSER_OUTPUT: RSS: Main: 178216960 17:45:17 INFO - 2015-11-23 17:45:17,269 DEBUG : BROWSER_OUTPUT: 17:45:19 INFO - 2015-11-23 17:45:19,985 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52581/tests/kraken/driver.html?testName=audio-dft) 17:45:20 INFO - 2015-11-23 17:45:20,554 DEBUG : BROWSER_OUTPUT: RSS: Main: 169463808 17:45:20 INFO - 2015-11-23 17:45:20,554 DEBUG : BROWSER_OUTPUT: 17:45:23 INFO - 2015-11-23 17:45:23,575 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52581/tests/kraken/driver.html?testName=audio-fft) 17:45:24 INFO - 2015-11-23 17:45:24,140 DEBUG : BROWSER_OUTPUT: RSS: Main: 154464256 17:45:24 INFO - 2015-11-23 17:45:24,140 DEBUG : BROWSER_OUTPUT: 17:45:26 INFO - 2015-11-23 17:45:26,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52581/tests/kraken/driver.html?testName=audio-oscillator) 17:45:26 INFO - 2015-11-23 17:45:26,766 DEBUG : BROWSER_OUTPUT: RSS: Main: 155422720 17:45:26 INFO - 2015-11-23 17:45:26,767 DEBUG : BROWSER_OUTPUT: 17:45:29 INFO - 2015-11-23 17:45:29,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52581/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:45:29 INFO - 2015-11-23 17:45:29,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 156303360 17:45:29 INFO - 2015-11-23 17:45:29,606 DEBUG : BROWSER_OUTPUT: 17:45:32 INFO - 2015-11-23 17:45:32,611 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52581/tests/kraken/driver.html?testName=imaging-darkroom) 17:45:33 INFO - 2015-11-23 17:45:33,177 DEBUG : BROWSER_OUTPUT: RSS: Main: 157257728 17:45:33 INFO - 2015-11-23 17:45:33,178 DEBUG : BROWSER_OUTPUT: 17:45:36 INFO - 2015-11-23 17:45:36,588 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52581/tests/kraken/driver.html?testName=imaging-desaturate) 17:45:37 INFO - 2015-11-23 17:45:37,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 157995008 17:45:37 INFO - 2015-11-23 17:45:37,175 DEBUG : BROWSER_OUTPUT: 17:45:40 INFO - 2015-11-23 17:45:40,013 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52581/tests/kraken/driver.html?testName=json-parse-financial) 17:45:40 INFO - 2015-11-23 17:45:40,594 DEBUG : BROWSER_OUTPUT: RSS: Main: 158785536 17:45:40 INFO - 2015-11-23 17:45:40,594 DEBUG : BROWSER_OUTPUT: 17:45:42 INFO - 2015-11-23 17:45:42,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52581/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:45:42 INFO - 2015-11-23 17:45:42,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 166666240 17:45:42 INFO - 2015-11-23 17:45:42,973 DEBUG : BROWSER_OUTPUT: 17:45:44 INFO - 2015-11-23 17:45:44,844 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:45:45 INFO - 2015-11-23 17:45:45,437 DEBUG : BROWSER_OUTPUT: RSS: Main: 165019648 17:45:45 INFO - 2015-11-23 17:45:45,437 DEBUG : BROWSER_OUTPUT: 17:45:47 INFO - 2015-11-23 17:45:47,595 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:45:48 INFO - 2015-11-23 17:45:48,176 DEBUG : BROWSER_OUTPUT: RSS: Main: 175710208 17:45:48 INFO - 2015-11-23 17:45:48,176 DEBUG : BROWSER_OUTPUT: 17:45:50 INFO - 2015-11-23 17:45:50,692 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:45:51 INFO - 2015-11-23 17:45:51,278 DEBUG : BROWSER_OUTPUT: RSS: Main: 181207040 17:45:51 INFO - 2015-11-23 17:45:51,278 DEBUG : BROWSER_OUTPUT: 17:45:53 INFO - 2015-11-23 17:45:53,886 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:45:54 INFO - 2015-11-23 17:45:54,459 DEBUG : BROWSER_OUTPUT: RSS: Main: 176726016 17:45:54 INFO - 2015-11-23 17:45:54,459 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,201 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52581/tests/kraken/driver.html?testName=ai-astar) 17:45:56 INFO - 2015-11-23 17:45:56,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 236539904 17:45:56 INFO - 2015-11-23 17:45:56,451 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,451 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |0;ai-astar;112;114;106;112;113;113;103;114;113;105 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;133;156;172;132;151;149;133;174;134 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |2;audio-dft;161;162;161;161;161;161;163;161;161;161 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |3;audio-fft;74;72;83;95;72;71;72;108;89;71 17:45:56 INFO - 2015-11-23 17:45:56,452 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;95;96;127;94;94;95;128;95;95;132 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;109;110;110;109;109;109;110 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;147;147;147;146;147;146;147;146;146 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;95;95;95;96;96;95;95;95;95 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;75;75;74;76;75;74;82;71;71 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;68;69;69;69;68;68;68 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;82;92;84;92;84;92;82;84;82 17:45:56 INFO - 2015-11-23 17:45:56,453 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;129;125;119;118;123;120;125;120;120;124 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;163;137;161;146;150;135;151;147;145;135 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;72;70;68;70;69;68;69;69 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: __start_cc_report 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,970 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: __end_cc_report 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: __startTimestamp1448329556450__endTimestamp 17:45:56 INFO - 2015-11-23 17:45:56,454 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: Number of tests: 14 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:113.00 stddev:4.14 (3.7%) stddev-sans-first:4.36 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: Values: 112.0 114.0 106.0 112.0 113.0 113.0 103.0 114.0 113.0 105.0 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:153.00 stddev:15.88 (10.4%) stddev-sans-first:16.69 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: Values: 155.0 133.0 156.0 172.0 132.0 151.0 149.0 133.0 174.0 134.0 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.30 Median:161.00 stddev:0.67 (0.4%) stddev-sans-first:0.71 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: Values: 161.0 162.0 161.0 161.0 161.0 161.0 163.0 161.0 161.0 161.0 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:80.70 Median:73.00 stddev:12.84 (17.6%) stddev-sans-first:13.39 17:45:56 INFO - 2015-11-23 17:45:56,458 DEBUG : BROWSER_OUTPUT: Values: 74.0 72.0 83.0 95.0 72.0 71.0 72.0 108.0 89.0 71.0 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:105.10 Median:95.00 stddev:16.55 (17.4%) stddev-sans-first:17.14 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 127.0 94.0 94.0 95.0 128.0 95.0 95.0 132.0 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.60 Median:110.00 stddev:0.52 (0.5%) stddev-sans-first:0.53 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 109.0 110.0 110.0 109.0 109.0 109.0 110.0 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: Values: 146.0 147.0 147.0 147.0 146.0 147.0 146.0 147.0 146.0 146.0 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,459 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.30 Median:95.00 stddev:0.48 (0.5%) stddev-sans-first:0.44 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: Values: 96.0 95.0 95.0 95.0 96.0 96.0 95.0 95.0 95.0 95.0 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:74.60 Median:75.00 stddev:3.10 (4.1%) stddev-sans-first:3.23 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: Values: 73.0 75.0 75.0 74.0 76.0 75.0 74.0 82.0 71.0 71.0 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.50 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 68.0 69.0 69.0 69.0 68.0 68.0 68.0 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,460 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:85.60 Median:84.00 stddev:4.50 (5.4%) stddev-sans-first:4.58 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: Values: 82.0 82.0 92.0 84.0 92.0 84.0 92.0 82.0 84.0 82.0 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.30 Median:123.50 stddev:3.47 (2.8%) stddev-sans-first:2.70 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: Values: 129.0 125.0 119.0 118.0 123.0 120.0 125.0 120.0 120.0 124.0 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.00 Median:148.50 stddev:9.83 (6.6%) stddev-sans-first:8.56 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: Values: 163.0 137.0 161.0 146.0 150.0 135.0 151.0 147.0 145.0 135.0 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.30 Median:69.50 stddev:1.25 (1.8%) stddev-sans-first:1.24 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 72.0 70.0 68.0 70.0 69.0 68.0 69.0 69.0 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:45:56 INFO - 2015-11-23 17:45:56,461 DEBUG : BROWSER_OUTPUT: 17:45:57 INFO - 2015-11-23 17:45:57,391 INFO : Browser exited with error code: 0 17:45:57 INFO - 2015-11-23 17:45:57,441 INFO : Completed test kraken (00:01:00) 17:45:57 INFO - 2015-11-23 17:45:57,442 INFO : Starting test v8_7 17:45:57 INFO - 2015-11-23 17:45:57,442 DEBUG : operating with platform_type : linux_ 17:45:57 INFO - 2015-11-23 17:45:57,442 INFO : Initialising browser for v8_7 test... 17:45:57 INFO - 2015-11-23 17:45:57,448 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18rdZT/profile http://localhost:52581/getInfo.html 17:46:01 INFO - 2015-11-23 17:46:01,350 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 17:46:01 INFO - 2015-11-23 17:46:01,350 DEBUG : BROWSER_OUTPUT: colorDepth:24 17:46:01 INFO - 2015-11-23 17:46:01,350 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 17:46:01 INFO - 2015-11-23 17:46:01,351 DEBUG : BROWSER_OUTPUT: __metrics 17:46:01 INFO - 2015-11-23 17:46:01,507 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 17:46:02 INFO - 2015-11-23 17:46:02,717 INFO : Browser initialized. 17:46:02 INFO - 2015-11-23 17:46:02,718 INFO : Running cycle 1/1 for v8_7 test... 17:46:02 INFO - 2015-11-23 17:46:02,718 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp18rdZT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 17:46:14 INFO - 2015-11-23 17:46:14,648 DEBUG : BROWSER_OUTPUT: RSS: Main: 142278656 17:46:14 INFO - 2015-11-23 17:46:14,648 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,187 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52581/tests/v8_7/run.html (next: http://localhost:52581/tests/v8_7/run.html) 17:46:36 INFO - 2015-11-23 17:46:36,433 DEBUG : BROWSER_OUTPUT: RSS: Main: 439033856 17:46:36 INFO - 2015-11-23 17:46:36,433 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: __start_tp_report 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: |0;Richards;186.08113137327874 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;185.7700167193015 17:46:36 INFO - 2015-11-23 17:46:36,435 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.87685418415896 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4970.297029702971 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1966.6011787819255 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |5;Earley;776.3975155279503 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |6;Boyer;12000 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |7;RegExp;27297.297297297297 17:46:36 INFO - 2015-11-23 17:46:36,436 DEBUG : BROWSER_OUTPUT: |8;Splay;605.294825511432 17:46:36 INFO - 2015-11-23 17:46:36,437 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 17:46:36 INFO - 2015-11-23 17:46:36,437 DEBUG : BROWSER_OUTPUT: __end_tp_report 17:46:36 INFO - 2015-11-23 17:46:36,437 DEBUG : BROWSER_OUTPUT: __startTimestamp1448329596434__endTimestamp 17:46:36 INFO - 2015-11-23 17:46:36,437 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,437 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: Number of tests: 10 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:186.08 Median:186.08 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: Values: 186.1 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:185.77 Median:185.77 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: Values: 185.8 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.88 Median:279.88 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: Values: 279.9 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4970.30 Median:4970.30 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,439 DEBUG : BROWSER_OUTPUT: Values: 4970.3 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1966.60 Median:1966.60 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: Values: 1966.6 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:776.40 Median:776.40 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: Values: 776.4 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12000.00 Median:12000.00 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: Values: 12000.0 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27297.30 Median:27297.30 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: Values: 27297.3 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:605.29 Median:605.29 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: Values: 605.3 17:46:36 INFO - 2015-11-23 17:46:36,440 DEBUG : BROWSER_OUTPUT: 17:46:36 INFO - 2015-11-23 17:46:36,441 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 17:46:36 INFO - 2015-11-23 17:46:36,441 DEBUG : BROWSER_OUTPUT: Values: 4835.7 17:46:36 INFO - 2015-11-23 17:46:36,441 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 17:46:36 INFO - 2015-11-23 17:46:36,441 DEBUG : BROWSER_OUTPUT: 17:46:37 INFO - 2015-11-23 17:46:37,379 INFO : Browser exited with error code: 0 17:46:37 INFO - 2015-11-23 17:46:37,391 INFO : Completed test v8_7 (00:00:39) 17:46:37 INFO - 2015-11-23 17:46:37,852 INFO : Completed test suite (00:20:18) 17:46:37 INFO - 2015-11-23 17:46:37,852 DEBUG : Working with test: dromaeo_css 17:46:37 INFO - 2015-11-23 17:46:37,852 DEBUG : Generating results file: dromaeo_css 17:46:37 INFO - 2015-11-23 17:46:37,853 DEBUG : Working with test: kraken 17:46:37 INFO - 2015-11-23 17:46:37,853 DEBUG : Generating results file: kraken 17:46:37 INFO - 2015-11-23 17:46:37,853 INFO : javascript benchmark 17:46:37 INFO - 2015-11-23 17:46:37,854 DEBUG : Working with test: v8_7 17:46:37 INFO - 2015-11-23 17:46:37,854 DEBUG : Generating results file: v8_7 17:46:37 INFO - 2015-11-23 17:46:37,854 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:37 INFO - 2015-11-23 17:46:37,908 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 17:46:37 INFO - 2015-11-23 17:46:37,908 DEBUG : process_Request line: dromaeo_css 6315.55 graph.html#tests=[[72,203,35]] 17:46:37 INFO - 2015-11-23 17:46:37,909 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:37 INFO - 2015-11-23 17:46:37,940 DEBUG : process_Request line: kraken 1525.00 graph.html#tests=[[232,203,35]] 17:46:37 INFO - 2015-11-23 17:46:37,940 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 17:46:37 INFO - 2015-11-23 17:46:37,982 DEBUG : process_Request line: v8_7 19708.87 graph.html#tests=[[230,203,35]] 17:46:37 INFO - 2015-11-23 17:46:37,983 INFO : javascript benchmark 17:46:38 INFO - 2015-11-23 17:46:37,986 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2622.409957759504, 2702.4324891772726, 2711.6068170115323, 2723.319170207448, 2746.052611848913, 4566.04113136241, 4658.27796691513, 4664.580187783103, 4692.859214223575, 4697.85906422807, 4604.171249175147, 4614.192516309649, 4697.812087516495, 4703.318018887259, 4720.268358404444, 4304.268274393361, 4313.676474264443, 4319.654427645781, 4326.264535029037, 4335.458067741532, 4160.750354978711, 4370.956290437102, 4383.211022016036, 4413.139437809628, 4414.249577571804, 4220.873373798791, 4298.828046878121, 4307.849225277131, 4312.504062032859, 4324.091940692459, 4339.392485052095, 4352.695311328208, 4359.629431498326, 4363.367311739812, 4414.823407063745, 4329.350597410382, 4339.305711086211, 4342.50061242958, 4362.956370436286, 4392.472903251598, 4460.107978404332, 4594.816207351702, 4620.745858977755, 4622.976885115553, 4716.693414928019, 4946.480619534969, 4954.777035033396, 4962.727050012248, 4963.950360496421, 4967.50324967504, 4983.277424773424, 4984.401871775374, 4987.152184128707, 4987.177115775893, 4987.226979818134, 4514.616257618107, 4616.76916154191, 4639.605633521121, 4640.327152562893, 4718.528147185322, 5151.072806894795, 5183.481651834786, 5190.455002224712, 5199.636025478256, 5230.947690523122, 4974.552290293891, 4982.975085124624, 4984.825531106394, 4986.90026199474, 5035.1188542005, 4856.344393506902, 4920.4095508538485, 4970.826021089245, 4976.850694479172, 5023.547880690682, 4997.85006449807, 4997.925031124536, 5004.474530174352, 5007.298978143063, 5057.468965758616, 4965.875853103701, 4967.105920934267, 4975.601951843843, 4978.601711863114, 5015.648904576645, 4022.718409711292, 4070.898227544276, 4110.609492098306, 4110.958890411118, 4113.691473139526, 3652.342578335925, 3702.1485058436174, 3708.2583483302906, 3710.8330125144435, 3716.9814150929615, 4282.293421585466, 4336.241157797373, 4338.240807858612, 4375.0, 4381.539938306496, 5003.449620541737, 5038.345015148007, 5073.720945348041, 5078.542931136216, 5120.564751996122, 4183.832646694098, 4290.120525292307, 4293.0769884474985, 4377.802998865059, 4406.669499787528, 4399.450068741407, 4442.511323754385, 4474.865754027384, 4491.30384790358, 4523.434570678665, 4776.068666610047, 4803.687760295569, 4812.374391329175, 4816.494268101799, 4820.469748327611, 4829.830955916526, 4895.902081958412, 5072.061668591175, 5076.593872490266, 5105.591552675852, 4631.6757826953135, 4695.483496815279, 4702.576768090888, 4732.408448943882, 4759.143354196278, 4940.950590494049, 4964.205727083649, 4966.751662416937, 4972.975135124301, 5009.724465154306, 5040.16837221869, 5047.444781074006, 5048.318477005557, 5052.5705315048635, 5093.796248150033, 4690.15577196108, 4749.145153872198, 4790.449098353594, 4796.088743138793, 4864.343313652753, 4880.853574392774, 4907.60739140875, 4907.60739140875, 4960.255961605788, 4960.677555958851, 4783.899703068383, 4796.784144713426, 4796.784144713566, 4804.351412559399, 4827.831025914076, 4748.453927798348, 4861.246506791453, 4862.562369386772, 4863.076015557032, 4868.3427737255015, 4671.929921051119, 4731.148393289241, 4816.8073277069925, 4835.758212089311, 4853.102176097434], "unit": "ms", "name": "dojo.html", "value": 4595.68886910318}, {"lowerIsBetter": false, "replicates": [544.5425842292472, 548.9011977843986, 576.976920923163, 578.4533615733131, 581.3459857660132, 27973.160805175827, 28718.712812871865, 37160.62839371602, 37400.43899341505, 37512.062198445055, 40808.38787418183, 41480.58519414805, 41501.58498415015, 41547.0, 41557.16885662285, 6964.512484126113, 7897.6840926362875, 8064.516129032248, 8065.919340806605, 8066.516009039477, 7035.437165026811, 7121.821954451154, 7135.785926422215, 7143.071400717899, 10240.180785537139, 10076.647317343895, 10170.491475426235, 10188.796224075513, 10196.592136314575, 10196.592136314575, 10046.598136074548, 10157.238207134495, 10161.136303414218, 10168.237382196328, 10171.4914254287, 6971.6862741176765, 7138.857222855566, 9958.601655933753, 10100.242481813893, 10359.171266298677, 35510.467342989876, 35511.64488355135, 35556.28887422263, 35569.82215088934, 35813.82093089544, 2786.317352248692, 2788.7629551487944, 2869.1679412970216, 2960.86676099576, 3481.2863363010524, 27326.5901011485, 27614.309642259104, 27901.235801771934, 27985.58021629677, 28316.85841570779, 3324.966750332514, 3387.6781705738163, 3424.3493736190294, 3469.167399824024, 3490.336836001177, 225237.0, 226325.0, 226481.0, 226668.0, 227114.0, 55319.72340138354, 55897.44102558922, 55982.720086399306, 55991.0, 56014.71992640011, 60105.0, 60167.0, 60382.39617603856, 60470.0, 60470.697646511486, 12446.128770986124, 12698.682532936751, 12756.107072505021, 12779.361031948365, 12799.296038717774, 10116.898831011596, 10163.085322321027, 10185.236107291983, 10189.388636681822, 10208.591656333812, 19059.856408615527, 19406.92500807846, 19466.011922845115, 19483.769341202868, 19538.413847584594, 7610.39116870649, 7738.961305193438, 7786.260305271104, 7793.961030194812, 7971.800704982422, 790.7311514085238, 795.3319211861948, 827.8261565071402, 873.0963452826421, 886.2201262888617, 26148.60777088307, 26198.08306709256, 26238.86880565585, 26526.336841579116, 26568.867155664484, 886.7916039730658, 901.693424235763, 923.5243849417556, 950.396498223633, 960.6685693435753, 13773.173609583457, 13982.930085349508, 14044.578662640137, 14272.643183920485, 14277.571672849832, 571886.0, 577238.0, 578793.0, 592771.0, 594261.0, 49373.75313123483, 49734.50265497299, 50019.0, 50023.49976500261, 50029.249561255885, 1175.9412029398668, 1191.8450601421932, 1194.5580135350149, 1201.9579314723942, 1207.2394391533278, 27715.584266236427, 28745.712542874302, 28926.566101508073, 29032.56451153192, 29203.415931681673, 42138.57861421347, 43130.1373972525, 43135.784321078194, 43147.0, 43169.13661726811, 248838.0, 250427.0, 250851.0, 250897.0, 251126.0, 34118.488222676184, 35472.29055418929, 36132.63867361293, 40253.39619905762, 40888.0, 37266.62733372632, 37350.43974340333, 37395.43906841345, 37418.251634967695, 37517.24965500729, 29897.402051959274, 30181.0, 34988.47517287192, 35212.82393588016, 38111.42832857454, 30711.846440768546, 34007.82996085004, 34400.0, 34541.65005978457, 34757.47863781995, 34622.65377346295, 34964.47553286652, 34992.0, 35004.82497587496, 35110.0, 27560.862195688893, 30854.53718194184, 31679.0, 31728.524072139397, 31744.206394840312, 23876.40308992289, 24370.634440483052, 24448.633270500603, 25097.24708258755, 25391.87304063542], "unit": "ms", "name": "ext.html", "value": 17701.670276187248}, {"lowerIsBetter": false, "replicates": [329.0867841739175, 332.17123277422826, 332.3187465695324, 333.5397151930337, 336.89387842829524, 11696.473658685358, 12176.269423834576, 14574.0, 15054.172020538866, 15917.52247432576, 11836.940815295911, 14575.489857854976, 14713.264336783172, 14808.111513309183, 14860.405583776663, 4880.8047678092835, 4887.902241955158, 5020.246962955568, 5034.697918124906, 5054.039732450822, 3328.034869887742, 3416.4533674612067, 4998.900021999558, 5022.648414610979, 6408.871822563546, 6471.061696054069, 6510.739570417178, 6598.274189839138, 6621.0, 6622.370874766913, 6452.516061295421, 6501.349865013508, 6536.738530458776, 6544.149260596139, 6554.27902930682, 6084.452399284086, 6261.530385221081, 6277.403646653606, 6290.056491526262, 6302.747890084391, 20242.5951480971, 20482.18071277147, 20769.89615051915, 20975.79024209769, 21010.894945525328, 1866.9813301866943, 1896.5922326699688, 1916.568772026297, 1924.7594050743658, 1966.6853303471376, 13134.408951597201, 13838.584842454642, 14026.228557429336, 14128.858711412857, 14312.998090133695, 1798.1638538079726, 1811.4927820210362, 1855.85153187746, 1888.745019422374, 1900.1734245603207, 59135.0, 63086.0, 63763.0, 63972.36027639711, 64657.67671161661, 15276.770848437282, 15308.0, 15351.385944562317, 15392.384304627913, 15413.075215487106, 23123.53752924932, 23162.768372316063, 23436.882815585814, 23477.882610587178, 23498.47522871583, 7483.70065197386, 7535.7362492313605, 7561.924380756122, 7566.924330756732, 7585.1656317805, 6073.362296958844, 6193.071039344134, 6202.379762023852, 6446.484281257488, 6471.708773105222, 7549.320561149523, 7557.773266802004, 7590.013298271189, 7649.349805266615, 7667.0, 1683.545442730456, 1747.6155245845894, 1751.9036452995208, 1771.76081229035, 2004.8772687295161, 828.8963879515061, 888.9155530224618, 912.9634814607474, 937.5031233446284, 966.1835748792225, 12802.295873727035, 14086.295685215699, 14976.62558436026, 15062.849371506363, 15396.307166177548, 789.4907784478979, 808.2967817998261, 835.8286551256978, 854.3677678517977, 910.1080940678172, 8345.791355216046, 8614.396992210484, 8634.5251011195, 8776.736697899074, 8851.07063758309, 441815.0, 472747.0, 498688.0, 500819.0, 500929.0, 68253.0, 68354.65822670855, 68686.31313686799, 68713.65643171853, 69162.65418672975, 998.6554638649654, 1013.5135135135176, 1044.185535282481, 1057.7778666479971, 1059.9788004239872, 13775.86224137786, 13795.0, 13834.896978946945, 14243.715125697636, 14331.211783352015, 32415.027549173563, 32753.50869736908, 33253.667463326026, 33571.83214083914, 33744.0, 41763.37354939617, 42426.363604546576, 43273.35089973716, 44007.0, 45659.0, 8554.91445085541, 8740.257078148174, 8804.64781408762, 8816.51509167002, 8847.247983921181, 15237.3905043797, 15427.69144617079, 15751.291191896622, 16148.67702645917, 16237.918810405872, 13454.125481843648, 13541.255230962392, 13639.931800340935, 13645.385957632128, 13995.790063149265, 13092.214467132002, 13192.406341714453, 13280.933595331962, 13520.59438216855, 13634.250116243702, 13308.40112194973, 13464.528741494001, 13569.457221711022, 13887.375068121757, 14059.367328470447, 8572.0, 8605.870911936452, 8721.258693011165, 8728.127187281221, 8771.298296136167, 9336.0, 9465.242780577675, 11868.821967670665, 13335.933320333725, 13637.659058523615], "unit": "ms", "name": "jquery.html", "value": 8874.445609462102}, {"lowerIsBetter": false, "replicates": [1394.0381137015465, 1575.4013474879546, 1616.070759313395, 1641.967160656787, 1647.9258433370496, 5848.619839710416, 6136.785212517563, 6504.252011018734, 6648.301928297519, 6651.401373876351, 6752.122224110859, 6792.898106528393, 6793.388595026447, 6798.388145066943, 6813.386795188432, 1735.878488505805, 1770.1060964213118, 2023.6660950943076, 2041.4896275931017, 2045.263705066175, 1981.4749091490767, 2024.3623258673545, 2025.1899240303849, 2026.8581199316054, 2028.452317874173, 2016.5966806638658, 2017.273781438681, 2026.4528577284125, 2077.0549400022956, 2080.43828166395, 2022.7471566054244, 2035.4504283843353, 2057.886816225107, 2062.257587268582, 2063.329417939176, 1991.6415045291842, 2017.7175195472646, 2019.717239586459, 2020.7373041504657, 2021.777604463508, 6519.119918810948, 6563.868722625569, 6568.343165683394, 6571.080048793173, 6571.112899758519, 3897.883063508071, 3942.9605703943166, 3952.980235098806, 3964.781936993464, 3972.1459886124335, 2556.5653838847443, 2603.0889188783963, 2633.3548280671166, 2646.827956182842, 2665.693445253801, 737.329030582173, 849.2696281198165, 851.7870532366908, 869.1091631078132, 874.9518776467291, 8823.205911467934, 8857.158569935782, 8862.689805856828, 8934.195922367018, 8937.329700272505, 3807.505024346817, 3822.885313440546, 3828.0238539172888, 3833.674137698327, 3843.6925045996254, 7786.649600767979, 7790.5325680459355, 7800.375969922393, 7802.102758182768, 7827.921720782833, 4023.3562629979065, 4044.9595504045174, 4052.3516237401873, 4054.918901621951, 4056.7971601419813, 3643.2713457308646, 3650.3611867923537, 3653.8538458461894, 3656.3784156693428, 3659.8902032939054, 3264.771465997357, 3280.5407242986003, 3302.78531895426, 3314.270860410754, 3337.1490269981487, 1031.3296357367772, 1044.6761503933806, 1050.033968748753, 1053.4574694032578, 1057.5293994172673, 854.1757204297758, 871.5424402188775, 872.8559787635096, 889.226373055446, 1131.6661584832493, 6437.678116094176, 6450.096986421905, 6467.676616169173, 6476.870462590816, 6477.514186436036, 415.93968874513024, 418.32440608417187, 433.9002029533225, 439.2510769138611, 441.8630224630311, 5052.8484145475695, 5106.157484015096, 5142.51146141116, 5143.7685304161405, 5145.536901678867, 7105.573665579978, 8009.7997550060545, 8010.198980101944, 8084.39367047462, 8086.797830054295, 7224.0608720867, 7683.692652293846, 7952.3638108951145, 8010.959945200237, 8028.638711258008, 6232.376762323732, 6310.4636105930595, 6339.96830015847, 6387.776427825004, 6394.552381333262, 6212.565120441706, 6413.230412350548, 6426.485881129592, 6427.132337134614, 6438.581492202992, 7090.220075791555, 7284.890726639211, 7291.30732580404, 7335.963320183579, 7344.118705755343, 7321.853562928818, 7423.554586724814, 7468.775936721907, 7474.327310542078, 7574.128975167926, 5826.0, 5845.970770146292, 5877.882442351214, 5886.381929897299, 5893.233879595625, 6232.906506402317, 6249.750009999549, 6283.654399007915, 6298.1812364392335, 6299.874002519832, 6141.877162456636, 6176.0, 6181.53638477125, 6278.246610406598, 6317.399847014526, 6148.877022459616, 6186.381361863778, 6190.969045154926, 6240.313565507699, 6287.434130928238, 6044.24446944132, 6076.0, 6090.0, 6093.786717465045, 6094.786682466092, 5456.317960254968, 5558.888822223452, 5591.189277554813, 5598.188262701804, 5823.126531020212, 5908.3205431375945, 5935.584509084495, 5949.613275137275, 5954.166416701752, 5958.523318134626], "unit": "ms", "name": "mootools.html", "value": 3816.2991090951537}, {"lowerIsBetter": false, "replicates": [306.20845115376756, 313.5030975903193, 318.05854670176285, 318.9489681650936, 319.0524143294415, 5212.8696782580455, 5252.290940723006, 5412.404635490093, 5480.26016487774, 5519.39286678465, 5143.897122057557, 5311.867203319919, 5319.20211968205, 5321.308229930113, 5357.571394288448, 3916.314644937139, 4008.33862412703, 4134.813933373005, 4149.854755083573, 4154.563770804068, 4011.117554138085, 4019.6985226108013, 4072.796360181994, 4091.856785012525, 4097.651699605537, 4031.052702614883, 4066.755994640316, 4094.75431474111, 4098.4876890388705, 4100.528439229482, 4083.509978802533, 4094.7747873866924, 4095.8361665533344, 4096.610821971908, 4102.2821006323775, 3602.2435288589168, 3602.9099272518133, 3607.3867442534834, 3608.7654302470255, 3613.981930090359, 5021.472745361721, 5127.435982041972, 5139.768710408003, 5142.640015198937, 5145.742712864342, 4737.076270127326, 4740.525947405266, 4745.477997420281, 4747.620190384761, 4748.264019077049, 5323.920141197885, 5590.832275031715, 5592.972035139839, 5602.439756024406, 5605.5515558755205, 3803.2773772983323, 3817.9618203817886, 3912.256671232457, 3915.11909820291, 3915.843366265346, 5785.103308987113, 5911.261092363455, 5913.8817223655715, 5915.438033386865, 5917.704114794286, 4015.3976903464713, 4017.77902215381, 4020.075382662004, 4023.5574086850424, 4024.2555127301544, 3993.72043956926, 4069.409935559327, 4074.3277359235985, 4086.7752273625238, 4093.4473846031, 4683.367745354333, 4690.906181876343, 4692.460367057832, 4692.7653617319, 4699.412573428322, 5581.2186293918885, 5613.803516876889, 5628.831135065872, 5630.296212973379, 5634.1830434586755, 1439.863212994764, 1460.8466111058185, 1464.2751837840124, 1464.4654701034258, 1465.3991863335982, 971.9222462203007, 971.9416834989923, 987.1017374189453, 1004.0561871840447, 1004.4073996342194, 5000.874978125576, 5007.148784706608, 5008.0, 5010.799568017312, 5011.599072074226, 5868.501177399969, 5873.471387575139, 5874.060150375919, 5880.14737863016, 5889.440503152194, 4999.875003124951, 5006.349174607278, 5006.6495345325475, 5007.273945277914, 5009.0, 3083.892063777757, 3146.65386807451, 3164.984175079156, 3171.0962375722806, 3172.0642410488963, 5536.197251398606, 5548.667079975215, 5551.195076713854, 5556.944430555724, 5557.194206839986, 5974.940250597525, 5977.611455255482, 5982.371850955674, 5994.550408719363, 5998.670073145931, 5408.9459105410015, 5533.972330138404, 5541.27963364768, 5546.112621980464, 5556.416576259516, 5815.273090863642, 5859.384764599656, 5860.2967643883, 5865.266841644794, 5871.706414679164, 5520.089185284543, 5673.858153546029, 5676.120201368794, 5682.857928551819, 5691.430856914441, 5436.483534064258, 5524.14375771756, 5544.63959842609, 5621.353544342453, 5634.408387119293, 4118.52636946755, 4120.25835349628, 4120.546739858553, 4124.7731374773475, 4129.442525259172, 5771.076627739541, 5901.734421951109, 5909.6158749681135, 5914.0, 5931.110333449845, 5716.771329146954, 5719.857003574777, 5721.885562288648, 5725.971370143123, 5726.656400615976, 5702.230198923092, 5713.05734553794, 5714.3999880012, 5717.7141142941855, 5718.228039214653, 5357.78568857257, 5520.66875987442, 5544.69504177258, 5556.361018482765, 5563.944360556505, 5750.568707346882, 5754.913676294943, 5763.703166787439, 5765.077587585966, 5765.308163020464, 5620.831375058755, 5625.803096891589, 5627.268455100811, 5629.746661400165, 5630.127330263816], "unit": "ms", "name": "prototype.html", "value": 4237.514013535409}, {"lowerIsBetter": false, "replicates": [745.5675708089309, 746.1009483572294, 752.713968691897, 754.3399525415261, 764.8546776112538, 11250.943745281273, 11503.654890353293, 11545.653630391082, 11607.187496875222, 11619.419029048546, 10281.691549253534, 11439.313641181536, 11524.366159861203, 11528.71178220545, 11538.769224615502, 741.2624438683517, 753.8416932444193, 754.9471536992413, 756.6292516666849, 757.1860250230997, 751.7143485475511, 759.7948553890446, 759.8138456078268, 760.1182628151346, 760.2739383888373, 789.5775759968418, 797.0873350014231, 797.1470526536608, 797.3262593108814, 797.9785874081185, 793.4089103617813, 795.3319211862034, 795.3517882925427, 795.9482633628795, 796.1560745609614, 587.1867463562996, 587.6855882103055, 588.0385569593702, 588.3763210996358, 588.5409380683074, 11474.0, 11476.4835582399, 11606.593769218121, 11610.24533405326, 11630.76738465226, 10820.621278255223, 10983.61557345489, 11153.66539003823, 11221.326720396803, 11604.6518604442, 8525.872111918326, 8612.0, 8701.260392866614, 8717.956410217972, 8770.956145219297, 3255.283837555734, 3299.9175020624434, 3300.85146168423, 3303.702666759979, 3305.388503126929, 39265.0, 40429.19141617151, 40852.18295634101, 40907.18185636271, 40967.795161024005, 8731.781705457415, 8811.471311721318, 8840.690575829814, 8874.068222836639, 8947.955260223787, 15481.767773483407, 15504.612384690474, 15529.223538823013, 15646.530604081896, 15662.921685391728, 6181.876362472725, 6226.782062627877, 6276.309605943343, 6332.176817013851, 6407.038944158414, 3504.229069604683, 3518.876839310663, 3520.0, 3552.378333791576, 3563.768355056965, 2574.9871250643628, 2594.4551644154562, 2604.2577865308294, 2611.9552179128123, 2613.372790530259, 470.348567234376, 475.529226066192, 475.7716296177785, 485.9951400486021, 493.4251596889655, 380.2755750295691, 396.2016536678595, 434.7782630858222, 509.76041260607457, 533.4212379568135, 7223.422126229889, 7226.024486694334, 7321.304476074764, 7671.079470463468, 7704.807379815549, 431.3034449364317, 492.8669259299969, 517.891242839008, 529.2881074954181, 550.4770468055364, 3465.4801779733243, 3503.1242189452637, 3515.33208690348, 3546.113471632092, 3766.60450652683, 42768.78615606964, 42778.35832462516, 42947.0, 42975.570244297785, 43067.13865722668, 40088.39867401991, 40558.39162412566, 40588.79705601453, 41266.79366603148, 45000.77499612481, 41961.0, 42432.99999999938, 42587.57412425836, 42647.0, 42962.78518607387, 7597.392208623186, 7748.302652761278, 7781.338586220235, 8063.27430531255, 8152.429329946846, 25792.09727659523, 27011.864940675958, 27468.313292167855, 30640.84679576588, 31794.205144871565, 36985.44521832228, 37173.0, 37452.0, 37826.810865945496, 37938.62061379351, 9020.368574199743, 9228.723138305862, 9414.62341506332, 9657.951710241405, 9690.961057520408, 10327.586896524355, 10804.945975270388, 10848.67453976382, 11024.724381890517, 11103.833442498531, 9612.66355677548, 9734.513274336114, 9779.80440391174, 9968.601255949681, 10160.441175735405, 9110.590023448829, 9158.542072896194, 9161.7866176929, 9192.264618830344, 9365.157135857806, 9017.954910225408, 9264.21254193374, 9476.336656433983, 9928.553215105481, 10224.539895704562, 8407.2433480987, 8476.872846907178, 8544.487330759926, 8577.399582029198, 8735.344849136467, 8172.713955011784, 8403.83192336162, 8516.74449766508, 8531.317494600293, 8784.956075219583], "unit": "ms", "name": "yui.html", "value": 5434.46067124488}], "name": "dromaeo_css", "value": 6315.551452153697}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 114.0, 106.0, 112.0, 113.0, 113.0, 103.0, 114.0, 113.0, 105.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [155.0, 133.0, 156.0, 172.0, 132.0, 151.0, 149.0, 133.0, 174.0, 134.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [161.0, 162.0, 161.0, 161.0, 161.0, 161.0, 163.0, 161.0, 161.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.3}, {"lowerIsBetter": true, "replicates": [74.0, 72.0, 83.0, 95.0, 72.0, 71.0, 72.0, 108.0, 89.0, 71.0], "unit": "ms", "name": "audio-fft", "value": 80.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 127.0, 94.0, 94.0, 95.0, 128.0, 95.0, 95.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 105.1}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 109.0, 109.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.6}, {"lowerIsBetter": true, "replicates": [146.0, 147.0, 147.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 95.0, 95.0, 95.0, 96.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.3}, {"lowerIsBetter": true, "replicates": [73.0, 75.0, 75.0, 74.0, 76.0, 75.0, 74.0, 82.0, 71.0, 71.0], "unit": "ms", "name": "json-parse-financial", "value": 74.6}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 68.0, 69.0, 69.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [82.0, 82.0, 92.0, 84.0, 92.0, 84.0, 92.0, 82.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 85.6}, {"lowerIsBetter": true, "replicates": [129.0, 125.0, 119.0, 118.0, 123.0, 120.0, 125.0, 120.0, 120.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.3}, {"lowerIsBetter": true, "replicates": [163.0, 137.0, 161.0, 146.0, 150.0, 135.0, 151.0, 147.0, 145.0, 135.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 147.0}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 72.0, 70.0, 68.0, 70.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.3}], "name": "kraken", "value": 1524.9999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [186.08113137327874], "unit": "score", "name": "Richards", "value": 189.712948}, {"lowerIsBetter": false, "replicates": [185.7700167193015], "unit": "score", "name": "DeltaBlue", "value": 355.9131939999999}, {"lowerIsBetter": false, "replicates": [279.87685418415896], "unit": "score", "name": "Encrypt", "value": 951.0647130000004}, {"lowerIsBetter": false, "replicates": [4970.297029702971], "unit": "score", "name": "Decrypt", "value": 53.55434462151397}, {"lowerIsBetter": false, "replicates": [1966.6011787819255], "unit": "score", "name": "RayTrace", "value": 376.2781228771229}, {"lowerIsBetter": false, "replicates": [776.3975155279503], "unit": "score", "name": "Earley", "value": 858.4043439999999}, {"lowerIsBetter": false, "replicates": [12000.0], "unit": "score", "name": "Boyer", "value": 55.53858333333334}, {"lowerIsBetter": false, "replicates": [27297.297297297297], "unit": "score", "name": "RegExp", "value": 33.37271782178218}, {"lowerIsBetter": false, "replicates": [605.294825511432], "unit": "score", "name": "Splay", "value": 134.63026043737577}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19708.86630382334}]} 17:46:38 INFO - RETURN: dromaeo_css: 6315.55 17:46:38 INFO - RETURN: kraken: 1525.00 17:46:38 INFO - RETURN: v8_7: 19708.87 17:46:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19708.87"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1525.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6315.55"}}} 17:46:38 INFO - Return code: 0 17:46:38 INFO - # TBPL SUCCESS # 17:46:38 INFO - Running post-action listener: _resource_record_post_action 17:46:38 INFO - Running post-run listener: _resource_record_post_run 17:46:39 INFO - Total resource usage - Wall time: 1232s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511582208; Read time: 8; Write time: 436264 17:46:39 INFO - install - Wall time: 14s; CPU: 14.0%; Read bytes: 0; Write bytes: 171606016; Read time: 0; Write time: 259228 17:46:39 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 339976192; Read time: 0; Write time: 177036 17:46:39 INFO - Running post-run listener: _upload_blobber_files 17:46:39 INFO - Blob upload gear active. 17:46:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 17:46:39 INFO - Copying logs to upload dir... 17:46:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1263.835826 ========= master_lag: -0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 3 secs) (at 2015-11-23 17:46:38.796933) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:46:38.800683) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010009 build_url: 'https://queue.taskcluster.net/v1/task/_CkPG0N3TLmjxorbDBCisA/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2' ========= master_lag: 0.04 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-23 17:46:38.851175) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:46:38.851495) ========= 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=5752742a61d0f534093fa7a9000001cb-1448328224.985262-1161154101 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004419 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-23 17:46:38.900849) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:46:38.901143) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-23 17:46:38.901426) ========= ========= Total master_lag: 0.20 =========