builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-063 starttime: 1448152593.23 results: success (0) buildid: 20151121160114 builduid: 5484fe723cda4d64b2dcad39c76efa58 revision: 7f501ebf62efdfebc32f23ff7be90edd824bce01 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.228739) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.229148) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.229462) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006504 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.261134) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.261457) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.317372) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.317657) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004666 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.367731) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.368043) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.368409) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.368721) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-21 16:36: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% 223M=0s 2015-11-21 16:36:33 (223 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.177662 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.562034) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.562736) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.014210 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:33.613954) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 16:36:33.614355) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev 7f501ebf62efdfebc32f23ff7be90edd824bce01 --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 7f501ebf62efdfebc32f23ff7be90edd824bce01 --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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-21 16:36:33,795 truncating revision to first 12 chars 2015-11-21 16:36:33,795 Setting DEBUG logging. 2015-11-21 16:36:33,795 attempt 1/10 2015-11-21 16:36:33,795 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/7f501ebf62ef?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-21 16:36:34,778 unpacking tar archive at: b2g-inbound-7f501ebf62ef/testing/mozharness/ program finished with exit code 0 elapsedTime=1.285049 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-21 16:36:34.914628) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:34.915303) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:34.924765) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:34.925384) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-21 16:36:34.926239) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-21 16:36:34.926760) ========= /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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 16:36:35 INFO - MultiFileLogger online at 20151121 16:36:35 in /builds/slave/test 16:36: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 16:36:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:36:35 INFO - {'append_to_log': False, 16:36:35 INFO - 'base_work_dir': '/builds/slave/test', 16:36:35 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 16:36:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:36:35 INFO - 'branch': 'B2G-Inbound-Non-PGO', 16:36:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:36:35 INFO - 'config_files': ('talos/linux_config.py',), 16:36:35 INFO - 'default_actions': ('clobber', 16:36:35 INFO - 'read-buildbot-config', 16:36:35 INFO - 'download-and-extract', 16:36:35 INFO - 'populate-webroot', 16:36:35 INFO - 'create-virtualenv', 16:36:35 INFO - 'install', 16:36:35 INFO - 'run-tests'), 16:36:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:36:35 INFO - 'download_minidump_stackwalk': True, 16:36:35 INFO - 'download_symbols': 'ondemand', 16:36:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:36:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:36:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:36:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:36:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:36:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:36:35 INFO - 'installer_path': 'installer.exe', 16:36:35 INFO - 'log_level': 'info', 16:36:35 INFO - 'log_name': 'talos', 16:36:35 INFO - 'log_to_console': True, 16:36:35 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 16:36:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 16:36:35 INFO - 'opt_config_files': (), 16:36:35 INFO - 'pip_index': False, 16:36:35 INFO - 'sps_profile': False, 16:36:35 INFO - 'sps_profile_interval': 0, 16:36:35 INFO - 'suite': 'dromaeojs', 16:36:35 INFO - 'system_bits': '64', 16:36:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:36:35 INFO - 'title': 'talos-linux64-ix-063', 16:36:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:36:35 INFO - 'use_talos_json': True, 16:36:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:36:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:36:35 INFO - 'work_dir': 'build'} 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running clobber step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: clobber 16:36:35 INFO - rmtree: /builds/slave/test/build 16:36:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running read-buildbot-config step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: read_buildbot_config 16:36:35 INFO - Using buildbot properties: 16:36:35 INFO - { 16:36:35 INFO - "properties": { 16:36:35 INFO - "buildnumber": 278, 16:36:35 INFO - "product": "firefox", 16:36:35 INFO - "script_repo_revision": "production", 16:36:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 16:36:35 INFO - "repository": "", 16:36:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 16:36:35 INFO - "buildid": "20151121160114", 16:36:35 INFO - "slavename": "talos-linux64-ix-063", 16:36:35 INFO - "pgo_build": "False", 16:36:35 INFO - "basedir": "/builds/slave/test", 16:36:35 INFO - "project": "", 16:36:35 INFO - "platform": "ubuntu64_hw", 16:36:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 16:36:35 INFO - "slavebuilddir": "test", 16:36:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 16:36:35 INFO - "branch": "b2g-inbound", 16:36:35 INFO - "repo_path": "integration/b2g-inbound", 16:36:35 INFO - "stage_platform": "linux64", 16:36:35 INFO - "builduid": "5484fe723cda4d64b2dcad39c76efa58", 16:36:35 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 16:36:35 INFO - }, 16:36:35 INFO - "sourcestamp": { 16:36:35 INFO - "repository": "", 16:36:35 INFO - "hasPatch": false, 16:36:35 INFO - "project": "", 16:36:35 INFO - "branch": "b2g-inbound-linux64-talos", 16:36:35 INFO - "changes": [ 16:36:35 INFO - { 16:36:35 INFO - "category": null, 16:36:35 INFO - "files": [ 16:36:35 INFO - { 16:36:35 INFO - "url": null, 16:36:35 INFO - "name": "https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 16:36:35 INFO - } 16:36:35 INFO - ], 16:36:35 INFO - "repository": "", 16:36:35 INFO - "rev": "7f501ebf62efdfebc32f23ff7be90edd824bce01", 16:36:35 INFO - "who": "fdesre@mozilla.com", 16:36:35 INFO - "when": 1448152557, 16:36:35 INFO - "number": 6692709, 16:36:35 INFO - "comments": "Bug 1223054 - Fix add-on registration r=ferjm", 16:36:35 INFO - "project": "", 16:36:35 INFO - "at": "Sat 21 Nov 2015 16:35:57", 16:36:35 INFO - "branch": "b2g-inbound-linux64-talos", 16:36:35 INFO - "revlink": "", 16:36:35 INFO - "properties": [ 16:36:35 INFO - [ 16:36:35 INFO - "buildid", 16:36:35 INFO - "20151121160114", 16:36:35 INFO - "Change" 16:36:35 INFO - ], 16:36:35 INFO - [ 16:36:35 INFO - "builduid", 16:36:35 INFO - "5484fe723cda4d64b2dcad39c76efa58", 16:36:35 INFO - "Change" 16:36:35 INFO - ], 16:36:35 INFO - [ 16:36:35 INFO - "pgo_build", 16:36:35 INFO - "False", 16:36:35 INFO - "Change" 16:36:35 INFO - ] 16:36:35 INFO - ], 16:36:35 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 16:36:35 INFO - } 16:36:35 INFO - ], 16:36:35 INFO - "revision": "7f501ebf62efdfebc32f23ff7be90edd824bce01" 16:36:35 INFO - } 16:36:35 INFO - } 16:36:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 16:36:35 INFO - Running post-action listener: _resource_record_post_action 16:36:35 INFO - ##### 16:36:35 INFO - ##### Running download-and-extract step. 16:36:35 INFO - ##### 16:36:35 INFO - Running pre-action listener: _resource_record_pre_action 16:36:35 INFO - Running main action method: download_and_extract 16:36:35 INFO - mkdir: /builds/slave/test/build/tests 16:36: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')]} 16:36:35 INFO - https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:36:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/test_packages.json 16:36:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/test_packages.json 16:36:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:36:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:36:37 INFO - Downloaded 1302 bytes. 16:36:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:36:37 INFO - Using the following test package requirements: 16:36:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 16:36:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'jsshell-linux-x86_64.zip'], 16:36:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 16:36:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 16:36:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 16:36:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 16:36:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 16:36:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 16:36:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 16:36:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 16:36: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')]} 16:36:37 INFO - https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:38 INFO - Downloaded 21338691 bytes. 16:36:38 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 16:36:38 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:38 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 16:36:39 INFO - Return code: 0 16:36:39 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 16:36:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:39 INFO - https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 16:36:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:41 INFO - Downloaded 21338691 bytes. 16:36: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 16:36:41 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 16:36: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 16:36:42 INFO - Return code: 0 16:36: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')]} 16:36:42 INFO - https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 16:36:42 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36:42 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36:42 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:44 INFO - Downloaded 11130997 bytes. 16:36: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 16:36:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 16:36: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 16:36:44 INFO - Return code: 0 16:36: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')]} 16:36:44 INFO - https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 16:36:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/pRofMxwLQEOHBdlBTHILog/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 16:36:45 INFO - Downloaded 55898085 bytes. 16:36:45 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:45 INFO - mkdir: /builds/slave/test/properties 16:36:45 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:36:45 INFO - Writing to file /builds/slave/test/properties/build_url 16:36:45 INFO - Contents: 16:36:45 INFO - build_url:https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 16:36:45 INFO - Running post-action listener: _resource_record_post_action 16:36:45 INFO - Running post-action listener: set_extra_try_arguments 16:36:45 INFO - ##### 16:36:45 INFO - ##### Running populate-webroot step. 16:36:45 INFO - ##### 16:36:45 INFO - Running pre-action listener: _resource_record_pre_action 16:36:45 INFO - Running main action method: populate_webroot 16:36:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:36:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:36:45 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:36:45 INFO - '../fennec_ids.txt'], 16:36:45 INFO - 'tests': ['tcheck2']}, 16:36:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:36:45 INFO - '--tppagecycles', 16:36:45 INFO - '7'], 16:36:45 INFO - 'tests': ['tsvgm']}}, 16:36:45 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:36:45 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:36:45 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:45 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:36:45 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:45 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:36:45 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'tests': ['damp', 'tps']}, 16:36:45 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['damp', 'tps']}, 16:36:45 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:36:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:36:45 INFO - 'other': {'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'other_l64': {'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'other_nol64': {'tests': ['a11yr', 16:36:45 INFO - 'ts_paint', 16:36:45 INFO - 'tpaint', 16:36:45 INFO - 'sessionrestore', 16:36:45 INFO - 'sessionrestore_no_auto_restore']}, 16:36:45 INFO - 'svgr': {'tests': ['tsvgx', 16:36:45 INFO - 'tsvgr_opacity', 16:36:45 INFO - 'tart', 16:36:45 INFO - 'tscrollx', 16:36:45 INFO - 'cart']}, 16:36:45 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['tsvgx', 16:36:45 INFO - 'tsvgr_opacity', 16:36:45 INFO - 'tart', 16:36:45 INFO - 'tscrollx', 16:36:45 INFO - 'cart']}, 16:36:45 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'tests': ['tp5o']}, 16:36:45 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'talos_options': ['--e10s'], 16:36:45 INFO - 'tests': ['tp5o']}, 16:36:45 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'talos_options': ['--xperf_path', 16:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:45 INFO - 'tests': ['tp5n']}, 16:36:45 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:36:45 INFO - 'talos_options': ['--e10s', 16:36:45 INFO - '--xperf_path', 16:36:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:36:45 INFO - 'tests': ['tp5n']}}, 16:36:45 INFO - 'talos.zip': {'path': '', 16:36:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:36:45 INFO - Running post-action listener: _resource_record_post_action 16:36:45 INFO - ##### 16:36:45 INFO - ##### Running create-virtualenv step. 16:36:45 INFO - ##### 16:36:45 INFO - Running pre-action listener: _resource_record_pre_action 16:36:45 INFO - Running main action method: create_virtualenv 16:36:45 INFO - Creating virtualenv /builds/slave/test/build/venv 16:36:45 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 16:36:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:36:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:36:45 INFO - Using real prefix '/usr' 16:36:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:36:46 INFO - Installing distribute.............................................................................................................................................................................................done. 16:36:48 INFO - Installing pip.................done. 16:36:48 INFO - Return code: 0 16:36:48 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:48 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:48 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 16:36:48 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 16:36:48 INFO - Using env: {'DISPLAY': ':0', 16:36:48 INFO - 'HOME': '/home/cltbld', 16:36:48 INFO - 'LANG': 'en_US.UTF-8', 16:36:48 INFO - 'LANGUAGE': 'en_US:en', 16:36:48 INFO - 'LOGNAME': 'cltbld', 16:36:48 INFO - 'MAIL': '/var/mail/cltbld', 16:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:48 INFO - 'MOZ_NO_REMOTE': '1', 16:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:48 INFO - 'NO_EM_RESTART': '1', 16:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:48 INFO - 'PWD': '/builds/slave/test', 16:36:48 INFO - 'SHELL': '/bin/bash', 16:36:48 INFO - 'SHLVL': '1', 16:36:48 INFO - 'TERM': 'linux', 16:36:48 INFO - 'TMOUT': '86400', 16:36:48 INFO - 'USER': 'cltbld', 16:36:48 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:48 INFO - '_': '/tools/buildbot/bin/python'} 16:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:48 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 16:36:48 INFO - Cleaning up... 16:36:48 INFO - Return code: 0 16:36:48 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:48 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:48 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 16:36:48 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 16:36:48 INFO - Using env: {'DISPLAY': ':0', 16:36:48 INFO - 'HOME': '/home/cltbld', 16:36:48 INFO - 'LANG': 'en_US.UTF-8', 16:36:48 INFO - 'LANGUAGE': 'en_US:en', 16:36:48 INFO - 'LOGNAME': 'cltbld', 16:36:48 INFO - 'MAIL': '/var/mail/cltbld', 16:36:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:48 INFO - 'MOZ_NO_REMOTE': '1', 16:36:48 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:48 INFO - 'NO_EM_RESTART': '1', 16:36:48 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:48 INFO - 'PWD': '/builds/slave/test', 16:36:48 INFO - 'SHELL': '/bin/bash', 16:36:48 INFO - 'SHLVL': '1', 16:36:48 INFO - 'TERM': 'linux', 16:36:48 INFO - 'TMOUT': '86400', 16:36:48 INFO - 'USER': 'cltbld', 16:36:48 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:48 INFO - '_': '/tools/buildbot/bin/python'} 16:36:48 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:48 INFO - Downloading/unpacking psutil>=0.7.1 16:36:48 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 16:36:48 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 16:36:48 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 16:36:48 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 16:36:48 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 16:36:48 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 16:36:50 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:36:50 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:36:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:36:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:50 INFO - Installing collected packages: psutil 16:36:50 INFO - Running setup.py install for psutil 16:36:50 INFO - building 'psutil._psutil_linux' extension 16:36:50 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 16:36:50 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 16:36:50 INFO - building 'psutil._psutil_posix' extension 16:36:50 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 16:36:50 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 16:36:50 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:36:50 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:36:50 INFO - Successfully installed psutil 16:36:50 INFO - Cleaning up... 16:36:51 INFO - Return code: 0 16:36:51 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:36:51 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')]} 16:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:51 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')]} 16:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:51 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:51 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 16:36:51 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 16:36:51 INFO - Using env: {'DISPLAY': ':0', 16:36:51 INFO - 'HOME': '/home/cltbld', 16:36:51 INFO - 'LANG': 'en_US.UTF-8', 16:36:51 INFO - 'LANGUAGE': 'en_US:en', 16:36:51 INFO - 'LOGNAME': 'cltbld', 16:36:51 INFO - 'MAIL': '/var/mail/cltbld', 16:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:51 INFO - 'MOZ_NO_REMOTE': '1', 16:36:51 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:51 INFO - 'NO_EM_RESTART': '1', 16:36:51 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:51 INFO - 'PWD': '/builds/slave/test', 16:36:51 INFO - 'SHELL': '/bin/bash', 16:36:51 INFO - 'SHLVL': '1', 16:36:51 INFO - 'TERM': 'linux', 16:36:51 INFO - 'TMOUT': '86400', 16:36:51 INFO - 'USER': 'cltbld', 16:36:51 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:51 INFO - '_': '/tools/buildbot/bin/python'} 16:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:51 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:36:51 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 16:36:51 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 16:36:51 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 16:36:51 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 16:36:51 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 16:36:51 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 16:36:52 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:36:52 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:36:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:36:52 INFO - Installing collected packages: mozsystemmonitor 16:36:52 INFO - Running setup.py install for mozsystemmonitor 16:36:53 INFO - Successfully installed mozsystemmonitor 16:36:53 INFO - Cleaning up... 16:36:53 INFO - Return code: 0 16:36:53 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:36:53 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')]} 16:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:53 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')]} 16:36:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:53 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:53 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 16:36:53 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 16:36:53 INFO - Using env: {'DISPLAY': ':0', 16:36:53 INFO - 'HOME': '/home/cltbld', 16:36:53 INFO - 'LANG': 'en_US.UTF-8', 16:36:53 INFO - 'LANGUAGE': 'en_US:en', 16:36:53 INFO - 'LOGNAME': 'cltbld', 16:36:53 INFO - 'MAIL': '/var/mail/cltbld', 16:36:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:53 INFO - 'MOZ_NO_REMOTE': '1', 16:36:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:53 INFO - 'NO_EM_RESTART': '1', 16:36:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:53 INFO - 'PWD': '/builds/slave/test', 16:36:53 INFO - 'SHELL': '/bin/bash', 16:36:53 INFO - 'SHLVL': '1', 16:36:53 INFO - 'TERM': 'linux', 16:36:53 INFO - 'TMOUT': '86400', 16:36:53 INFO - 'USER': 'cltbld', 16:36:53 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:53 INFO - '_': '/tools/buildbot/bin/python'} 16:36:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:53 INFO - Downloading/unpacking blobuploader==1.2.4 16:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:54 INFO - Downloading blobuploader-1.2.4.tar.gz 16:36:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:36:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:36:55 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:36:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:36:55 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:36:55 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:36:55 INFO - Downloading docopt-0.6.1.tar.gz 16:36:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:36:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:36:55 INFO - Installing collected packages: blobuploader, requests, docopt 16:36:55 INFO - Running setup.py install for blobuploader 16:36:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:36:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:36:55 INFO - Running setup.py install for requests 16:36:56 INFO - Running setup.py install for docopt 16:36:56 INFO - Successfully installed blobuploader requests docopt 16:36:56 INFO - Cleaning up... 16:36:56 INFO - Return code: 0 16:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:56 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:56 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 16:36:56 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 16:36:56 INFO - Using env: {'DISPLAY': ':0', 16:36:56 INFO - 'HOME': '/home/cltbld', 16:36:56 INFO - 'LANG': 'en_US.UTF-8', 16:36:56 INFO - 'LANGUAGE': 'en_US:en', 16:36:56 INFO - 'LOGNAME': 'cltbld', 16:36:56 INFO - 'MAIL': '/var/mail/cltbld', 16:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:56 INFO - 'MOZ_NO_REMOTE': '1', 16:36:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:56 INFO - 'NO_EM_RESTART': '1', 16:36:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:56 INFO - 'PWD': '/builds/slave/test', 16:36:56 INFO - 'SHELL': '/bin/bash', 16:36:56 INFO - 'SHLVL': '1', 16:36:56 INFO - 'TERM': 'linux', 16:36:56 INFO - 'TMOUT': '86400', 16:36:56 INFO - 'USER': 'cltbld', 16:36:56 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:56 INFO - '_': '/tools/buildbot/bin/python'} 16:36:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:56 INFO - Running setup.py (path:/tmp/pip-u_Yaft-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:56 INFO - Running setup.py (path:/tmp/pip-ICFJeC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:56 INFO - Running setup.py (path:/tmp/pip-4jPueY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:56 INFO - Running setup.py (path:/tmp/pip-dYf9l6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:56 INFO - Running setup.py (path:/tmp/pip-Wr49hg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:36:56 INFO - Running setup.py (path:/tmp/pip-Ev0qYM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:36:56 INFO - Running setup.py (path:/tmp/pip-rugyqi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:36:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:36:56 INFO - Running setup.py (path:/tmp/pip-7YxlQk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:36:57 INFO - Running setup.py (path:/tmp/pip-GRuIyY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:36:57 INFO - Running setup.py (path:/tmp/pip-b3F7ns-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:36:57 INFO - Running setup.py (path:/tmp/pip-_WN2gc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:36:57 INFO - Running setup.py (path:/tmp/pip-W9oA2H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:36:57 INFO - Running setup.py (path:/tmp/pip-9beShK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:36:57 INFO - Running setup.py (path:/tmp/pip-KgDEss-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:57 INFO - Running setup.py (path:/tmp/pip-qXDA1y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:36:57 INFO - Running setup.py (path:/tmp/pip-p6XRNw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:36:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:36:57 INFO - Running setup.py (path:/tmp/pip-rQ89eG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:36:57 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:36:57 INFO - Running setup.py install for manifestparser 16:36:57 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:36:57 INFO - Running setup.py install for mozcrash 16:36:57 INFO - Running setup.py install for mozdebug 16:36:57 INFO - Running setup.py install for mozdevice 16:36:58 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozfile 16:36:58 INFO - Running setup.py install for mozhttpd 16:36:58 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozinfo 16:36:58 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozInstall 16:36:58 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozleak 16:36:58 INFO - Running setup.py install for mozlog 16:36:58 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for moznetwork 16:36:58 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozprocess 16:36:58 INFO - Running setup.py install for mozprofile 16:36:58 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:36:58 INFO - Running setup.py install for mozrunner 16:36:59 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:36:59 INFO - Running setup.py install for mozscreenshot 16:36:59 INFO - Running setup.py install for moztest 16:36:59 INFO - Running setup.py install for mozversion 16:36:59 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:36:59 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:36:59 INFO - Cleaning up... 16:36:59 INFO - Return code: 0 16:36:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:36:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:36:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:36:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:36:59 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 16:36:59 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 16:36:59 INFO - Using env: {'DISPLAY': ':0', 16:36:59 INFO - 'HOME': '/home/cltbld', 16:36:59 INFO - 'LANG': 'en_US.UTF-8', 16:36:59 INFO - 'LANGUAGE': 'en_US:en', 16:36:59 INFO - 'LOGNAME': 'cltbld', 16:36:59 INFO - 'MAIL': '/var/mail/cltbld', 16:36:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:36:59 INFO - 'MOZ_NO_REMOTE': '1', 16:36:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:36:59 INFO - 'NO_EM_RESTART': '1', 16:36:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:36:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:36:59 INFO - 'PWD': '/builds/slave/test', 16:36:59 INFO - 'SHELL': '/bin/bash', 16:36:59 INFO - 'SHLVL': '1', 16:36:59 INFO - 'TERM': 'linux', 16:36:59 INFO - 'TMOUT': '86400', 16:36:59 INFO - 'USER': 'cltbld', 16:36:59 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:36:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:36:59 INFO - '_': '/tools/buildbot/bin/python'} 16:36:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:36:59 INFO - Running setup.py (path:/tmp/pip-7GY5zf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:36:59 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)) 16:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:36:59 INFO - Running setup.py (path:/tmp/pip-iCMkan-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:36:59 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)) 16:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:36:59 INFO - Running setup.py (path:/tmp/pip-6Cb6x1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:36:59 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)) 16:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:36:59 INFO - Running setup.py (path:/tmp/pip-wK7OLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:36:59 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)) 16:36:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:36:59 INFO - Running setup.py (path:/tmp/pip-G8vWjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:37:00 INFO - Running setup.py (path:/tmp/pip-GzpNAx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:37:00 INFO - Running setup.py (path:/tmp/pip-qEKWWz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:37:00 INFO - Running setup.py (path:/tmp/pip-OLfToW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:37:00 INFO - Running setup.py (path:/tmp/pip-4WrGAs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:37:00 INFO - Running setup.py (path:/tmp/pip-gZGro9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:37:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:37:00 INFO - Running setup.py (path:/tmp/pip-a_sIaz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:37:00 INFO - Running setup.py (path:/tmp/pip-Jk2kz9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:37:00 INFO - Running setup.py (path:/tmp/pip-ZCmA0R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:37:00 INFO - Running setup.py (path:/tmp/pip-OvkfMV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:00 INFO - Running setup.py (path:/tmp/pip-Ytxhl0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:37:00 INFO - Running setup.py (path:/tmp/pip-Xf_C1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:37:00 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)) 16:37:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:37:00 INFO - Running setup.py (path:/tmp/pip-_hrD34-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:37:00 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)) 16:37:00 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)) 16:37:00 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)) 16:37:00 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)) 16:37:00 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)) 16:37:00 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)) 16:37:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:37:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:37:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:37:02 INFO - Downloading blessings-1.5.1.tar.gz 16:37:02 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 16:37:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:37:02 INFO - Installing collected packages: blessings 16:37:02 INFO - Running setup.py install for blessings 16:37:02 INFO - Successfully installed blessings 16:37:02 INFO - Cleaning up... 16:37:02 INFO - Return code: 0 16:37:02 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:37:02 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:02 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:03 INFO - Reading from file tmpfile_stdout 16:37:03 INFO - Current package versions: 16:37:03 INFO - argparse == 1.2.1 16:37:03 INFO - blessings == 1.5.1 16:37:03 INFO - blobuploader == 1.2.4 16:37:03 INFO - docopt == 0.6.1 16:37:03 INFO - manifestparser == 1.1 16:37:03 INFO - mozInstall == 1.12 16:37:03 INFO - mozcrash == 0.16 16:37:03 INFO - mozdebug == 0.1 16:37:03 INFO - mozdevice == 0.47 16:37:03 INFO - mozfile == 1.2 16:37:03 INFO - mozhttpd == 0.7 16:37:03 INFO - mozinfo == 0.9 16:37:03 INFO - mozleak == 0.1 16:37:03 INFO - mozlog == 3.0 16:37:03 INFO - moznetwork == 0.27 16:37:03 INFO - mozprocess == 0.22 16:37:03 INFO - mozprofile == 0.27 16:37:03 INFO - mozrunner == 6.11 16:37:03 INFO - mozscreenshot == 0.1 16:37:03 INFO - mozsystemmonitor == 0.0 16:37:03 INFO - moztest == 0.7 16:37:03 INFO - mozversion == 1.4 16:37:03 INFO - psutil == 3.1.1 16:37:03 INFO - requests == 1.2.3 16:37:03 INFO - wsgiref == 0.1.2 16:37:03 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:37:03 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')]} 16:37:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:37:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:03 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')]} 16:37:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:37:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:37:03 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 0x7f63135b9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1dd46c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e85900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, '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': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', '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 16:37:03 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 16:37:03 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 16:37:03 INFO - Using env: {'DISPLAY': ':0', 16:37:03 INFO - 'HOME': '/home/cltbld', 16:37:03 INFO - 'LANG': 'en_US.UTF-8', 16:37:03 INFO - 'LANGUAGE': 'en_US:en', 16:37:03 INFO - 'LOGNAME': 'cltbld', 16:37:03 INFO - 'MAIL': '/var/mail/cltbld', 16:37:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:03 INFO - 'MOZ_NO_REMOTE': '1', 16:37:03 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:03 INFO - 'NO_EM_RESTART': '1', 16:37:03 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:03 INFO - 'PWD': '/builds/slave/test', 16:37:03 INFO - 'SHELL': '/bin/bash', 16:37:03 INFO - 'SHLVL': '1', 16:37:03 INFO - 'TERM': 'linux', 16:37:03 INFO - 'TMOUT': '86400', 16:37:03 INFO - 'USER': 'cltbld', 16:37:03 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:37:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:03 INFO - '_': '/tools/buildbot/bin/python'} 16:37:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 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)) 16:37:03 INFO - Cleaning up... 16:37:03 INFO - Return code: 0 16:37:03 INFO - Running post-action listener: _resource_record_post_action 16:37:03 INFO - Running post-action listener: _start_resource_monitoring 16:37:03 INFO - Starting resource monitoring. 16:37:03 INFO - ##### 16:37:03 INFO - ##### Running install step. 16:37:03 INFO - ##### 16:37:03 INFO - Running pre-action listener: _resource_record_pre_action 16:37:03 INFO - Running main action method: install 16:37:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:37:03 INFO - Reading from file tmpfile_stdout 16:37:03 INFO - Detecting whether we're running mozinstall >=1.0... 16:37:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:37:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:37:03 INFO - Reading from file tmpfile_stdout 16:37:03 INFO - Output received: 16:37:03 INFO - Usage: mozinstall [options] installer 16:37:03 INFO - Options: 16:37:03 INFO - -h, --help show this help message and exit 16:37:03 INFO - -d DEST, --destination=DEST 16:37:03 INFO - Directory to install application into. [default: 16:37:03 INFO - "/builds/slave/test"] 16:37:03 INFO - --app=APP Application being installed. [default: firefox] 16:37:03 INFO - mkdir: /builds/slave/test/build/application 16:37:03 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'] 16:37:03 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 16:37:17 INFO - Reading from file tmpfile_stdout 16:37:17 INFO - Output received: 16:37:17 INFO - /builds/slave/test/build/application/firefox/firefox 16:37:17 INFO - Running post-action listener: _resource_record_post_action 16:37:17 INFO - ##### 16:37:17 INFO - ##### Running run-tests step. 16:37:17 INFO - ##### 16:37:17 INFO - Running pre-action listener: _resource_record_pre_action 16:37:17 INFO - Running main action method: run_tests 16:37:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:37:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:37:17 INFO - Python 2.7.3 16:37:17 INFO - Return code: 0 16:37:17 INFO - grabbing minidump binary from tooltool 16:37:17 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:37:17 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 0x1ecbb70>, '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 0x1f1cdc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1f1d250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:37:17 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 16:37:17 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 16:37:17 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:37:17 INFO - Return code: 0 16:37:17 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 16:37:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:37:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:37:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 16:37:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:37:17 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/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] in /builds/slave/test/build 16:37:17 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/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-063 --webServer localhost 16:37:17 INFO - Using env: {'DISPLAY': ':0', 16:37:17 INFO - 'HOME': '/home/cltbld', 16:37:17 INFO - 'LANG': 'en_US.UTF-8', 16:37:17 INFO - 'LANGUAGE': 'en_US:en', 16:37:17 INFO - 'LOGNAME': 'cltbld', 16:37:17 INFO - 'MAIL': '/var/mail/cltbld', 16:37:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:37:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 16:37:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:37:17 INFO - 'MOZ_NO_REMOTE': '1', 16:37:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:37:17 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 16:37:17 INFO - 'NO_EM_RESTART': '1', 16:37:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 16:37:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:37:17 INFO - 'PWD': '/builds/slave/test', 16:37:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:37:17 INFO - 'SHELL': '/bin/bash', 16:37:17 INFO - 'SHLVL': '1', 16:37:17 INFO - 'TERM': 'linux', 16:37:17 INFO - 'TMOUT': '86400', 16:37:17 INFO - 'USER': 'cltbld', 16:37:17 INFO - 'XDG_SESSION_COOKIE': 'edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773', 16:37:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:37:17 INFO - '_': '/tools/buildbot/bin/python'} 16:37:17 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/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-063', '--webServer', 'localhost'] with output_timeout 3600 16:37:18 INFO - mozversion INFO | application_buildid: 20151121160114 16:37:18 INFO - mozversion INFO | application_changeset: 7f501ebf62efdfebc32f23ff7be90edd824bce01 16:37:18 INFO - mozversion INFO | application_display_name: Nightly 16:37:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:37:18 INFO - mozversion INFO | application_name: Firefox 16:37:18 INFO - mozversion INFO | application_remotingname: firefox 16:37:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 16:37:18 INFO - mozversion INFO | application_vendor: Mozilla 16:37:18 INFO - mozversion INFO | application_version: 45.0a1 16:37:18 INFO - mozversion INFO | platform_buildid: 20151121160114 16:37:18 INFO - mozversion INFO | platform_changeset: 7f501ebf62efdfebc32f23ff7be90edd824bce01 16:37:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 16:37:18 INFO - mozversion INFO | platform_version: 45.0a1 16:37:18 INFO - 2015-11-21 16:37:18,064 DEBUG : using testdate: 1448152638 16:37:18 INFO - 2015-11-21 16:37:18,064 DEBUG : actual date: 1448152638 16:37:18 INFO - 2015-11-21 16:37:18,072 INFO : starting webserver on 'localhost:56463' 16:37:18 INFO - 2015-11-21 16:37:18,073 INFO : Starting test suite talos-linux64-ix-063 16:37:18 INFO - 2015-11-21 16:37:18,073 INFO : Starting test dromaeo_css 16:37:18 INFO - 2015-11-21 16:37:18,074 DEBUG : operating with platform_type : linux_ 16:37:18 INFO - 2015-11-21 16:37:18,074 INFO : Initialising browser for dromaeo_css test... 16:37:18 INFO - 2015-11-21 16:37:18,091 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_n8njQ/profile http://localhost:56463/getInfo.html 16:37:23 INFO - 2015-11-21 16:37:23,122 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:37:23 INFO - 2015-11-21 16:37:23,123 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:37:23 INFO - 2015-11-21 16:37:23,123 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:37:23 INFO - 2015-11-21 16:37:23,123 DEBUG : BROWSER_OUTPUT: __metrics 16:37:23 INFO - 2015-11-21 16:37:23,224 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:37:24 INFO - 2015-11-21 16:37:24,410 INFO : Browser initialized. 16:37:24 INFO - 2015-11-21 16:37:24,411 INFO : Running cycle 1/1 for dromaeo_css test... 16:37:24 INFO - 2015-11-21 16:37:24,411 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_n8njQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:37:36 INFO - 2015-11-21 16:37:36,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 141942784 16:37:36 INFO - 2015-11-21 16:37:36,359 DEBUG : BROWSER_OUTPUT: 16:38:27 INFO - 2015-11-21 16:38:27,814 DEBUG : BROWSER_OUTPUT: 1448152707812 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] 16:40:40 INFO - 2015-11-21 16:40:40,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56463/tests/dromaeo/cssquery-ext.html) 16:40:41 INFO - 2015-11-21 16:40:41,134 DEBUG : BROWSER_OUTPUT: RSS: Main: 240398336 16:40:41 INFO - 2015-11-21 16:40:41,134 DEBUG : BROWSER_OUTPUT: 16:43:43 INFO - 2015-11-21 16:43:43,490 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-ext.html (next: http://localhost:56463/tests/dromaeo/cssquery-jquery.html) 16:43:44 INFO - 2015-11-21 16:43:44,063 DEBUG : BROWSER_OUTPUT: RSS: Main: 222572544 16:43:44 INFO - 2015-11-21 16:43:44,063 DEBUG : BROWSER_OUTPUT: 16:46:46 INFO - 2015-11-21 16:46:46,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56463/tests/dromaeo/cssquery-mootools.html) 16:46:46 INFO - 2015-11-21 16:46:46,760 DEBUG : BROWSER_OUTPUT: RSS: Main: 221138944 16:46:46 INFO - 2015-11-21 16:46:46,760 DEBUG : BROWSER_OUTPUT: 16:49:48 INFO - 2015-11-21 16:49:48,663 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56463/tests/dromaeo/cssquery-prototype.html) 16:49:49 INFO - 2015-11-21 16:49:49,236 DEBUG : BROWSER_OUTPUT: RSS: Main: 202842112 16:49:49 INFO - 2015-11-21 16:49:49,236 DEBUG : BROWSER_OUTPUT: 16:52:51 INFO - 2015-11-21 16:52:51,974 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56463/tests/dromaeo/cssquery-yui.html) 16:52:52 INFO - 2015-11-21 16:52:52,540 DEBUG : BROWSER_OUTPUT: RSS: Main: 206254080 16:52:52 INFO - 2015-11-21 16:52:52,540 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,132 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/dromaeo/cssquery-yui.html (next: http://localhost:56463/tests/dromaeo/cssquery-dojo.html) 16:55:55 INFO - 2015-11-21 16:55:55,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 250535936 16:55:55 INFO - 2015-11-21 16:55:55,394 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,395 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:55:55 INFO - 2015-11-21 16:55:55,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:55:55 INFO - 2015-11-21 16:55:55,395 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:55:55 INFO - 2015-11-21 16:55:55,395 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:55:55 INFO - 2015-11-21 16:55:55,396 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2653.1377302376727;2697.9325516862086;2723.4008518126006;2734.753872151506;2754.3389586499247;4504.842330518432;4634.6292296616275;4661.30080487927;4680.953190468094;4698.060387922416;4673;4712.528747125286;4785.258284965836;4795.808167673297;4803.783829727662;4254.936175957363;4282.164977829325;4389.38548603195;4407.338899165119;4407.801648925806;4169.291220492523;4339.674524410666;4378.737275763465;4401.845935392262;4459.977700111495;4153.771542565158;4241.936370954438;4249.065205654751;4253.043065310296;4267.722598031118;4336.848210312655;4358.411614432042;4362.192994296033;4403.515613282536;4406.49325327585;4138.8344466221315;4336.544662810423;4345.869623911288;4354.433923589945;4390.846320378771;4479.037007043468;4488.977555112204;4525.660575456854;4635.559621835921;4680.461746899082;5070.797168113271;5073.7209453480045;5076.923846142274;5090.160123579605;5130.769115389817;4747.786349614275;5114.539691427753;5117.232415137722;5118.897622047538;5120.846374608767;4604.746738929358;4621.468531118964;4715.83494577695;4780.928286075712;4839.177339852234;5135.38375394955;5137.794488220429;5140.485951404829;5140.871478213075;5188.8443346698905;4939.234418665113;4945.851624451272;4949.727764972961;4954.232094025432;4985.177445721488;4795.712257264575;4898.8775280618265;4901.215805471107;4906.95093049065;5039.622028347889;4924.60603151747;5047.116754568009;5065.037642847848;5082.593392528589;5096.439391666913;5035.420926593489;5044.319016932741;5052.9242061369105;5062.594992400599;5099.6175286852895;4006.4991876015497;4212.094399704079;4256.531781504032;4258.957410425918;4304.655627549789;3637.690796282293;3696.5748938871834;3702.018964974284;3733.533308336458;3738.476613274144;4320.330348795942;4325.718828276152;4332.631726303236;4339.522652508222;4402.3176407656865;4716.3868697069165;4982.402111746614;4983.551480366785;4987.825426110068;5002.549770520671;4263.211305908417;4277.550857159953;4297.140571885635;4332.826686932487;4340.348947657877;4468.106378724268;4471.172833025836;4476.194285028726;4483.641308695296;4502.977485112553;4545.681802273809;4797.496262892346;4799.880002999953;4803.855884323476;4839.830605928775;4982.775775090202;4986.700797952134;5009.248612708123;5091.745412729423;5130.281760553451;4782.569568738831;4808.711477311373;4815.518448155157;4821.951780482291;4873.707577545359;4720.858374248778;4986.526280003394;5010.87472813168;5013.448520662797;5058.797648094035;4930.038642464685;4936;4951.158303088411;5023.397192336943;5024.221245706921;4869.220924652039;4871.123197824426;4873.805047798049;4882.048000639841;4916.557509824133;4655.813767449264;4902.411710594752;4906.092372911023;4908.484609116134;4965.4289756678445;4566.223741963808;4631.351610774562;4637.489876113692;4647.512011238907;4706.058788242297;4951.306817045688;4961.8511444656715;4965.106280869334;4966.205407134841;5000.57495112905;4604.631629469702;4863.10032643962;4868.537488938545;4870.756462176806;4901.828436004723 16:55:55 INFO - 2015-11-21 16:55:55,397 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.7086544131611;572.6420986883198;583.2825624481884;587.4008511318456;592.1177445606046;28898.988535401266;29695.703042969562;38057.42913856291;38541.614583854156;38677;41813.790931045376;42303;42394.364084538676;42401.575984240146;42465.78767106168;6997.720091196346;7866.763997080083;8015.9178510900865;8023.197680231989;8023.719169829057;7031.296870312954;9757.756056098584;9994.600215991351;9999.700008999742;10001.849972250386;10038.14675752562;10084.092431681147;10099.848502272473;10111;10113.646022389217;7263.3462988330775;7451;10241.590336386536;10327.27709060366;10362.481875906213;9596.90403095974;9715.90284097157;9722.756931076708;9731.075547822946;9732.70801875945;38751.418728719094;39207.803960980295;39297.607023929966;39312.60687393118;39386.60613393887;2949.601803756487;2952.070097919149;2978.970210297891;3041.7870749047574;3543.20277937462;28513.85743071292;28674.713252867412;29296;29317.560236596255;29625.40749185004;3451.879184228565;3485.721142308609;3544.2379888323876;3546.769459985093;3599.7300202484657;226350;227394;227836;228169;228727.99999999834;51100.23349649758;54206.45793542014;54206.728966354916;63417.68291158514;64467.67766161139;57900.4209957895;57969.13046304309;57976.4202357971;58051.70974145102;58134.7093264531;12710.364481775874;12879.034072444605;12908.031897607718;12915.354232288348;12918;9315.301352398597;9362.953185234166;9365.157135857806;9427.858582121273;9462.337636365388;18905.90547047256;19082.236710531422;19278.32525861588;19294.614107717767;19311.51721206981;7160.713571457188;7359.484836061424;7412.407007439392;7412.55385722721;7472.476926615193;751.8609057324412;826.5784449930578;836.1053672570291;850.8128211793396;907.6460180529599;26000.219993400227;26062.73937260641;26260.474790504464;26351;26476.338091547866;922.377395258198;935.854942483916;944.9811003779886;952.9237660987104;963.4989805301344;14275.42898284057;14801.703965920622;14821.25893705332;15034.398624054915;15051.623709407133;270149;275134;275310;275326;275427;47874;48016.75991620089;48120.518794812306;48125.27812082751;48162.759186203846;1177.464253764535;1228.0237211416766;1244.7697176022284;1249.2816630437353;1262.223732404583;26709.46581068329;27617.447651046463;27882.581761274003;28309.292267693472;28328.716712832607;38084.428733568464;41278.174436510504;41687.1662566753;41697.58302416937;41725;155646;239063;244063;244074;244725;26678.333041674112;27235.727642724112;27302.590461143496;27353.589696154973;27363.179104626095;36084;39647.80176099101;39863.20273594454;40815;40997;30256.697433025387;30333.69666303397;30436.543451848684;31414.05757827269;31683.84158079195;30738.231544210677;31051.68948310488;31064.534031989086;31223;31273;30520.23699407444;31255.687443125276;31497;31642.36715265728;31655.366892661557;27999.30001749891;29199.7080029197;29955.463790016718;29987.850060749555;30152;23064.192753253556;23854.52290954206;25107.49785004253;25415.6187657189;25669.486610268064 16:55:55 INFO - 2015-11-21 16:55:55,397 DEBUG : BROWSER_OUTPUT: |2;jquery.html;335.21057908625204;337.65896444590953;342.5238917904113;343.5070673583408;344.6897791987212;12061.45723442445;12456.252624842517;15104.697906041873;15152.318145683443;15743.055416674993;12091.395430228496;14384.496542621011;14914.701705965874;15497.380104795822;15502.922485387586;4847.757612119406;4919.917618124007;4987.177115775893;5041.588355260533;5045.596352291808;3282.9015129546033;3381.171612954817;4981.078500477405;6470.644114573696;6709.597424154542;6457.8708425831455;6628.801135965929;6630.071789949411;6683.097781799468;6692.263850976388;6612.70242839071;6629.701663425158;6633.568818026837;6642.103316052319;6648.833779155511;5892.911606325909;6117.84705382369;6124.2957059938235;6338.651374174418;6342.207224096988;18711.625767484573;18876.81123188778;19014.71477927832;19213.903930480257;19253.807461925342;1859.618778150476;1995.4013795861329;2011.306099395706;2014.1540552967788;2056.7223424837753;12860.164089334163;12908.290044047573;12920.612381628565;12992.350382480838;13225.338733063309;1824.5712257619448;1829.3688677406274;1870.653929023135;1920.4238728381429;1967.8819270843794;51318.48681513174;53316;55656;56227.43772562304;56904.43095569074;14648.460893520114;15320.23398830054;15359.923200383926;15426.228688565527;15703.842961570239;22551.32346029622;22735.317940461813;22839.20062797794;22852;22869.313920582408;7733.7679869604;7737.729179478803;7758.9137520747145;7759.7672069838;7809.921900781033;6232.034034724625;6252.030935205051;6262.15460912771;6269.843253918597;6313.589616674902;6683.796916554969;7625.961870190725;7643.515857346385;7660.655270512841;7661.578613176329;1770.6812773700858;1777.4578753480312;1784.3933062758724;1793.0944872839132;2237.5636750833755;399.57445320733325;403.61858044148585;863.2360361080489;915.7802127489488;971.0968799016982;9344.813103737888;10100.949495252476;11648.009919156797;14354.425822967174;14523.85476145225;798.1858504325671;838.5429940682343;848.4357901995104;858.536390349217;873.1661263493348;8179.141190174946;8798.604062817189;8931.508767017747;8963.252165827731;9057.731917531552;492560;498668;512080;512590;518491;67475.32524674789;68273.31726682669;70097;70337.64831175811;70812;1084.2301965604508;1089.5696200001114;1095.9342439453658;1104.6851647280487;1108.7505311304892;13893.722125557635;13941.930290348484;14032.789508157182;14068.859311407165;14275.21486318221;32542.51186232161;32698.50952235766;33154.33691326208;33683.3263334727;34060;42282;43399.34900976425;43521.12957740764;43535.56464435442;47039.588812335685;8471.66113355459;8885.289176865706;8913.064128266438;8931.240844528287;8947.015828259016;10247.590096396061;10316.43259620728;14581.343839527035;15703.528894133195;15808.446704365751;13038.739225215253;13298.734025319633;13379.464821407035;13485.056046076681;13891.305434728021;10416.06255436984;12202.694932626755;12592.87407125917;13207.933960330136;13267.33663316811;9645.035496450299;10951.945240273748;11893.702657433634;12234.204776689487;12666.240025598494;8443.746687599381;8545.444546104483;8599.96800383958;8605.483670979762;8620.310375169845;8282.461639993382;9493.715188544355;12087.576934807239;12165.33090680021;12296.139270251355 16:55:55 INFO - 2015-11-21 16:55:55,398 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1397.3432486731233;1646.1686848141687;1675.4136052381668;1700.3453670336917;1713.700102482066;5852.531797456204;6342.33405492423;6548.1814773153355;6554.803355899318;6567.244766851813;6688.598684078958;6775;6817.488688348369;6819.295176205948;6836.863262734742;2091.8744875307493;2106.8735875847497;2109.789021097893;2115.079940226007;2115.6614941609346;2074.605824893273;2095.6332641787626;2096.360610013945;2100.0864623888583;2100.28590279305;2041.9387418377473;2079.4385515910694;2090.247510896084;2095.078165607136;2096.3501314592527;2061.4949337412354;2065.2874758208395;2075.138817390781;2075.699023641571;2077.2521892118825;2047.0481226229874;2047.1606641277006;2088.2691058129685;2089.2583132987725;2091.8326533877407;5700.087985922232;5868.618539794899;6750.426213771835;6776.457883369319;6782.966085169543;3553.7690050146916;3606.9278614427562;4031.07285324377;4156.314208155651;4204.306289462235;2732.3169207698074;2743.6433263675594;2783.4154827486254;2789.0656630028966;2827.0670678676192;888.6800751729372;908.5729707037682;929.8419268724333;938.2259635800492;951.2295041016729;9018.954905225497;9070.682526111621;9091.27269818413;9094.545272736337;9100.36297459178;3912.139329347539;3918.059665680273;3974.841006359771;3989.4414781930554;3996.460477835455;7887.2507111825435;7940.523568585903;7967.800804979922;7970.322522585529;7985.321247693895;4147.129102888367;4150.211459822624;4159.688023398257;4162.292410290258;4163.02168990287;3753.6809371203753;3755.4742336072973;3756.6806821420487;3763.7929913854455;3766.3408903441787;3322.601287845474;3323.7673362864366;3335.982525329749;3353.3963886500665;3370.0732298617586;1085.913126949842;1103.150574057987;1103.2938919091787;1105.4362275239685;1115.3976852499723;933.7012156110115;1000.6397696829135;1138.823482360219;1160.489384670742;1164.4003338280793;6426.839329016812;6453.709583068773;6480.384363485461;6499.967500162469;6505.056766768792;1043.7181960870523;1044.6970378590124;1052.6841947415744;1057.0486562094022;1084.6745976207105;4549;5063.11395505785;5098.5411312982005;5111.105556527593;5117.8720531987;7039.788806335818;7847.332976697045;7939.404544659174;7965;7989.800254993672;7870.094939081964;8016.519008859487;8048.5975701215875;8049.074356448966;8058.11360750317;6177.660228687465;6556.541042127005;6562.146920900348;6576.736930522821;6582.210134783761;6435.935640643534;6444.13004244421;6489.253735820253;6492.837679058061;6506.869862602627;7162.319579639926;7324.08448943882;7409.518381305198;7410.5183163094225;7414.814629634302;7207.207207207098;7575.6969721210535;7609.124950630749;7645.388368930583;7666.1950495199435;6456.12842266288;6513.185851768529;6562.77030303937;6589.6705164740615;6593.3736295051895;6590.670466476753;6612.107365505787;6625.509260416367;6644.302348253364;6657.1345725055435;6194.163787888578;6287.96856015717;6305.621662700252;6308.053791931247;6369.8726025480155;6092.725827337869;6216.564840461125;6256.812295631138;6258.186435763321;6378.298387177314;6327.272363678052;6374.58565193261;6377.266614339411;6381.93618063832;6390.137331460193;5546.112621980464;5547.639403438763;5575.9163612545035;5590.692511911721;5603.131514615241;5957.940420595912;5996.970015150071;6037.698115094316;6063.211782468251;6073.089036644362 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: |4;prototype.html;309.61143764575456;314.0406059488262;316.6864803844195;320.7321886225002;322.3987263753101;5270;5434.239206511092;5508.724563771805;5522.447755224475;5527.889442211153;5278.392984806748;5404.054290499166;5412.891742165154;5414.025475414423;5426.9185962210595;3974.880753577397;4042.555318914932;4071.674266058723;4224.640905523034;4244.4270023546815;4134.193832202722;4175.415441838145;4193.329067349225;4194.727342722728;4203.285441474942;4145.896352591194;4155.66754659628;4156.896077598054;4157.3140431828715;4162.1675664867;3931.4495970564003;4023.2154729827694;4054.736442131252;4075.7962101894786;4120.876373708764;3613.94579081314;3616.3490571697084;3646.08847788053;3648.562172539312;3661.4690869823994;5155.690658560461;5194.480551944813;5201.921971170397;5204.531592156686;5210.843674689765;4775.307580400857;4778.092162489151;4780.713157210544;4781.306710526954;4785.258284965836;5510.9448905511235;5638.830835074954;5652.265205523297;5680.829575112712;5690.60165788395;3971.4042893565907;3973.165635216608;3974.5826688197903;3977.1449138435087;3977.244323578511;5919.5560332974765;6005.39946005396;6010.128531362928;6012.398760123996;6013.218281623361;4071.185762847442;4100.159467309194;4104.261232978033;4108.589141085868;4112.09533902541;4026.59734026595;4161.313383291723;4167.395727619539;4169.6455801256625;4175.707700460999;4737.336772851803;4772.5943294819635;4773.594244489188;4775.403074615673;4776.617870570415;5684.886302274014;5695.914561281584;5701.743421546041;5703.885922281531;5704.657720536781;1442.596073099534;1474.329180222996;1476.372541669786;1476.4758510728752;1476.6898951220364;986.5412583148727;989.8069876374038;992.538469611634;994.8855881573567;1014.4217795856291;5012.198048312325;5013.974930125326;5025.246213067996;5027.296178535008;5030.421501527371;5891.263592050994;5909;5922.230110085661;5923.318818335861;5935.258092738408;5026.220935754964;5026.421961474404;5034.874128146753;5039.3448851649055;5039.395272567315;3028.545718142252;3071.3550154467366;3174.349258402022;3178.666240044808;3214.2125179330747;5615.691136987423;5637.830865074055;5641.2384328116;5643.633163844337;5653.038983372837;6113.663748493876;6119.051547010221;6132.601380910227;6141.723622437001;6145.907811382833;5506.889862202814;5622.887542249132;5638.774449022158;5642.463965923231;5649.06790379591;5883.794067207627;5896.380880007709;5935;5991.850203744942;5998.4601385875485;5839.5036421904615;5843.707814609337;5844.94155058444;5848.912266315923;5851.64890106595;5554.944450555443;5656.095024796013;5659.660420374791;5665.971670141623;5667.716614169358;4180.895477613084;4235.767032813224;4238.512571054245;4239;4241.787910604396;5913.793017244376;5915.615484993462;5916.171735957056;5919.4080591940465;5922;5671.829845104653;5676.120201368794;5683;5683.744231509675;5689.231953686365;5522.6134170609275;5666.773329066791;5672.064109421899;5674.943250567441;5685.971570142288;5555.472230138131;5558.110702287615;5560.249366335493;5561.582881283839;5561.944380556142;5645.9153112702525;5695.943040569541;5711.371749107512;5713.371529131875;5720.199172115824;5478.8904221914545;5566.332040155207;5571.721413929368;5575.0522411191005;5583.302087239095 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: |5;yui.html;641.3906788550877;768.5657603454048;776.9067711874576;786.2216405758301;805.5166899860081;10639.468026598668;10857.34855908644;10858.402787846675;10870.61952831651;10890.128789696815;11707.765844683101;13500.932495337534;13812.171269723824;13821.37803798829;13833.17000979942;621.9004959206528;628.8868003759321;792.5957761541598;808.8584497712906;809.6761295481825;629.1663545801808;801.5631480842925;809.0372456776447;816.3591580609223;816.7019038051099;833.3416600885294;847.7244895408986;848.0586548930683;848.6393282854793;849.218718778722;652.5856081388305;659.630606860155;818.6602559937619;843.2579330189425;843.4854738609444;614.8155553333982;615.3600255734032;615.7383112177307;615.8645098078416;616.4328817487922;11568.826467602992;11692.766144677058;11703.356315402649;11707.121965852595;11724.179307448481;10303.587856485732;11182.66452006441;11184.720381990433;11438.942805286004;11528.423578821026;9116;9197.862032069525;9211.447313161232;9250.35247532673;9333.393329433566;3237.465818140004;3250.6261779895376;3256.560364350806;3281.6390197078304;3282.6881446262805;41147.177056459004;41389.793051034554;41400.79299603483;41490.37764433506;41568.584314156775;8818.118188181259;8986.05646407131;9378.95310523443;9380.90619093814;9460.810783784424;15933.840661593467;15946.840531594768;15949.840501595068;15964.680706385807;15974.76037859433;6588;6640.369164929324;6651.926752943489;6702.128723266042;6921.688524016431;3629.7822130672243;3653.725970552219;3726.8509259629855;3747.569029561581;3778.112143646241;2825.4914115459005;2857.6856545780365;2860.3707184419395;2863.6134121893692;2868.3689588290545;497.8406909788905;498.9151844186497;500.47200203784627;502.1488576862184;503.5644167794831;490.77914938277206;531.7926008856549;597.5010865927;614.4991831657185;626.786892456567;7930.484518506279;7973.322267607318;7975.72084977023;8019.15798841125;8160.755177344689;605.9242594675666;624.4723208888482;632.6836581709146;636.9681515924185;643.9066335381343;3637.890863274106;3890.2414029264587;3903.902402439905;3977.164795392942;4021.1153546219784;51222.743886281074;51251.23123153156;51386;51423.48576514262;51871.221931671054;44874.10251794946;45248.095038099054;45510.08979820385;45788.3131753024;45813.77093114513;41978.790106049884;42048;42681.78659106685;42932.78533607374;43385.99999999937;7654.885176722242;7711.845763084595;7761.417893658111;7884.174454518833;7960.920390796249;32144.83927580347;32704.182395440304;32868.34263314768;33074.83462582672;33367;38536.42195367016;39262.60737392589;39808.20383592254;39855.40216896691;39940.60059399369;10744.677659670222;10765.407902565434;10877.401742904216;10951.069159121564;11090.667279981613;11485.82771258415;11510.59712910044;11516.19386642927;11520.366379849189;11559.479823407799;10475.16198704117;10766.676999690022;10802.891971080502;10812.45937703096;11439.428028598702;10458.58165673395;10607.151427885596;10702.571897124028;10773.353598784099;11028.724281893017;7694.2687895223125;9797.363171393836;10341.069303762397;10424.113950314308;10542.841857371992;8822.25010874083;8871.467711937305;8900.73297801067;9014.18872301496;9606.183474404754;8962.507062111647;9252.629894804402;9263.814723705353;9272.350935434455;9351.766205844908 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,900 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: __startTimestamp1448153755394__endTimestamp 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:55:55 INFO - 2015-11-21 16:55:55,400 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:55:55 INFO - 2015-11-21 16:55:55,401 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,401 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4634.55 Median:4782.57 stddev:481.37 (10.1%) stddev-sans-first:457.06 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: Values: 2653.1 2697.9 2723.4 2734.8 2754.3 4504.8 4634.6 4661.3 4681.0 4698.1 4673.0 4712.5 4785.3 4795.8 4803.8 4254.9 4282.2 4389.4 4407.3 4407.8 4169.3 4339.7 4378.7 4401.8 4460.0 4153.8 4241.9 4249.1 4253.0 4267.7 4336.8 4358.4 4362.2 4403.5 4406.5 4138.8 4336.5 4345.9 4354.4 4390.8 4479.0 4489.0 4525.7 4635.6 4680.5 5070.8 5073.7 5076.9 5090.2 5130.8 4747.8 5114.5 5117.2 5118.9 5120.8 4604.7 4621.5 4715.8 4780.9 4839.2 5135.4 5137.8 5140.5 5140.9 5188.8 4939.2 4945.9 4949.7 4954.2 4985.2 4795.7 4898.9 4901.2 4907.0 5039.6 4924.6 5047.1 5065.0 5082.6 5096.4 5035.4 5044.3 5052.9 5062.6 5099.6 4006.5 4212.1 4256.5 4259.0 4304.7 3637.7 3696.6 3702.0 3733.5 3738.5 4320.3 4325.7 4332.6 4339.5 4402.3 4716.4 4982.4 4983.6 4987.8 5002.5 4263.2 4277.6 4297.1 4332.8 4340.3 4468.1 4471.2 4476.2 4483.6 4503.0 4545.7 4797.5 4799.9 4803.9 4839.8 4982.8 4986.7 5009.2 5091.7 5130.3 4782.6 4808.7 4815.5 4822.0 4873.7 4720.9 4986.5 5010.9 5013.4 5058.8 4930.0 4936.0 4951.2 5023.4 5024.2 4869.2 4871.1 4873.8 4882.0 4916.6 4655.8 4902.4 4906.1 4908.5 4965.4 4566.2 4631.4 4637.5 4647.5 4706.1 4951.3 4961.9 4965.1 4966.2 5000.6 4604.6 4863.1 4868.5 4870.8 4901.8 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40696.09 Median:31455.53 stddev:63663.24 (202.4%) stddev-sans-first:63770.47 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: Values: 549.7 572.6 583.3 587.4 592.1 28899.0 29695.7 38057.4 38541.6 38677.0 41813.8 42303.0 42394.4 42401.6 42465.8 6997.7 7866.8 8015.9 8023.2 8023.7 7031.3 9757.8 9994.6 9999.7 10001.8 10038.1 10084.1 10099.8 10111.0 10113.6 7263.3 7451.0 10241.6 10327.3 10362.5 9596.9 9715.9 9722.8 9731.1 9732.7 38751.4 39207.8 39297.6 39312.6 39386.6 2949.6 2952.1 2979.0 3041.8 3543.2 28513.9 28674.7 29296.0 29317.6 29625.4 3451.9 3485.7 3544.2 3546.8 3599.7 226350.0 227394.0 227836.0 228169.0 228728.0 51100.2 54206.5 54206.7 63417.7 64467.7 57900.4 57969.1 57976.4 58051.7 58134.7 12710.4 12879.0 12908.0 12915.4 12918.0 9315.3 9363.0 9365.2 9427.9 9462.3 18905.9 19082.2 19278.3 19294.6 19311.5 7160.7 7359.5 7412.4 7412.6 7472.5 751.9 826.6 836.1 850.8 907.6 26000.2 26062.7 26260.5 26351.0 26476.3 922.4 935.9 945.0 952.9 963.5 14275.4 14801.7 14821.3 15034.4 15051.6 270149.0 275134.0 275310.0 275326.0 275427.0 47874.0 48016.8 48120.5 48125.3 48162.8 1177.5 1228.0 1244.8 1249.3 1262.2 26709.5 27617.4 27882.6 28309.3 28328.7 38084.4 41278.2 41687.2 41697.6 41725.0 155646.0 239063.0 244063.0 244074.0 244725.0 26678.3 27235.7 27302.6 27353.6 27363.2 36084.0 39647.8 39863.2 40815.0 40997.0 30256.7 30333.7 30436.5 31414.1 31683.8 30738.2 31051.7 31064.5 31223.0 31273.0 30520.2 31255.7 31497.0 31642.4 31655.4 27999.3 29199.7 29955.5 29987.9 30152.0 23064.2 23854.5 25107.5 25415.6 25669.5 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,402 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:27222.03 Median:343.02 stddev:82654.87 (24096.5%) stddev-sans-first:82862.08 16:55:55 INFO - 2015-11-21 16:55:55,403 DEBUG : BROWSER_OUTPUT: Values: 335.2 337.7 342.5 343.5 344.7 12061.5 12456.3 15104.7 15152.3 15743.1 12091.4 14384.5 14914.7 15497.4 15502.9 4847.8 4919.9 4987.2 5041.6 5045.6 3282.9 3381.2 4981.1 6470.6 6709.6 6457.9 6628.8 6630.1 6683.1 6692.3 6612.7 6629.7 6633.6 6642.1 6648.8 5892.9 6117.8 6124.3 6338.7 6342.2 18711.6 18876.8 19014.7 19213.9 19253.8 1859.6 1995.4 2011.3 2014.2 2056.7 12860.2 12908.3 12920.6 12992.4 13225.3 1824.6 1829.4 1870.7 1920.4 1967.9 51318.5 53316.0 55656.0 56227.4 56904.4 14648.5 15320.2 15359.9 15426.2 15703.8 22551.3 22735.3 22839.2 22852.0 22869.3 7733.8 7737.7 7758.9 7759.8 7809.9 6232.0 6252.0 6262.2 6269.8 6313.6 6683.8 7626.0 7643.5 7660.7 7661.6 1770.7 1777.5 1784.4 1793.1 2237.6 399.6 403.6 863.2 915.8 971.1 9344.8 10100.9 11648.0 14354.4 14523.9 798.2 838.5 848.4 858.5 873.2 8179.1 8798.6 8931.5 8963.3 9057.7 492560.0 498668.0 512080.0 512590.0 518491.0 67475.3 68273.3 70097.0 70337.6 70812.0 1084.2 1089.6 1095.9 1104.7 1108.8 13893.7 13941.9 14032.8 14068.9 14275.2 32542.5 32698.5 33154.3 33683.3 34060.0 42282.0 43399.3 43521.1 43535.6 47039.6 8471.7 8885.3 8913.1 8931.2 8947.0 10247.6 10316.4 14581.3 15703.5 15808.4 13038.7 13298.7 13379.5 13485.1 13891.3 10416.1 12202.7 12592.9 13207.9 13267.3 9645.0 10951.9 11893.7 12234.2 12666.2 8443.7 8545.4 8600.0 8605.5 8620.3 8282.5 9493.7 12087.6 12165.3 12296.1 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4817.32 Median:6068.15 stddev:2406.02 (39.6%) stddev-sans-first:2399.04 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: Values: 1397.3 1646.2 1675.4 1700.3 1713.7 5852.5 6342.3 6548.2 6554.8 6567.2 6688.6 6775.0 6817.5 6819.3 6836.9 2091.9 2106.9 2109.8 2115.1 2115.7 2074.6 2095.6 2096.4 2100.1 2100.3 2041.9 2079.4 2090.2 2095.1 2096.4 2061.5 2065.3 2075.1 2075.7 2077.3 2047.0 2047.2 2088.3 2089.3 2091.8 5700.1 5868.6 6750.4 6776.5 6783.0 3553.8 3606.9 4031.1 4156.3 4204.3 2732.3 2743.6 2783.4 2789.1 2827.1 888.7 908.6 929.8 938.2 951.2 9019.0 9070.7 9091.3 9094.5 9100.4 3912.1 3918.1 3974.8 3989.4 3996.5 7887.3 7940.5 7967.8 7970.3 7985.3 4147.1 4150.2 4159.7 4162.3 4163.0 3753.7 3755.5 3756.7 3763.8 3766.3 3322.6 3323.8 3336.0 3353.4 3370.1 1085.9 1103.2 1103.3 1105.4 1115.4 933.7 1000.6 1138.8 1160.5 1164.4 6426.8 6453.7 6480.4 6500.0 6505.1 1043.7 1044.7 1052.7 1057.0 1084.7 4549.0 5063.1 5098.5 5111.1 5117.9 7039.8 7847.3 7939.4 7965.0 7989.8 7870.1 8016.5 8048.6 8049.1 8058.1 6177.7 6556.5 6562.1 6576.7 6582.2 6435.9 6444.1 6489.3 6492.8 6506.9 7162.3 7324.1 7409.5 7410.5 7414.8 7207.2 7575.7 7609.1 7645.4 7666.2 6456.1 6513.2 6562.8 6589.7 6593.4 6590.7 6612.1 6625.5 6644.3 6657.1 6194.2 6288.0 6305.6 6308.1 6369.9 6092.7 6216.6 6256.8 6258.2 6378.3 6327.3 6374.6 6377.3 6381.9 6390.1 5546.1 5547.6 5575.9 5590.7 5603.1 5957.9 5997.0 6037.7 6063.2 6073.1 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4728.40 Median:5420.47 stddev:1394.13 (25.7%) stddev-sans-first:1358.01 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: Values: 309.6 314.0 316.7 320.7 322.4 5270.0 5434.2 5508.7 5522.4 5527.9 5278.4 5404.1 5412.9 5414.0 5426.9 3974.9 4042.6 4071.7 4224.6 4244.4 4134.2 4175.4 4193.3 4194.7 4203.3 4145.9 4155.7 4156.9 4157.3 4162.2 3931.4 4023.2 4054.7 4075.8 4120.9 3613.9 3616.3 3646.1 3648.6 3661.5 5155.7 5194.5 5201.9 5204.5 5210.8 4775.3 4778.1 4780.7 4781.3 4785.3 5510.9 5638.8 5652.3 5680.8 5690.6 3971.4 3973.2 3974.6 3977.1 3977.2 5919.6 6005.4 6010.1 6012.4 6013.2 4071.2 4100.2 4104.3 4108.6 4112.1 4026.6 4161.3 4167.4 4169.6 4175.7 4737.3 4772.6 4773.6 4775.4 4776.6 5684.9 5695.9 5701.7 5703.9 5704.7 1442.6 1474.3 1476.4 1476.5 1476.7 986.5 989.8 992.5 994.9 1014.4 5012.2 5014.0 5025.2 5027.3 5030.4 5891.3 5909.0 5922.2 5923.3 5935.3 5026.2 5026.4 5034.9 5039.3 5039.4 3028.5 3071.4 3174.3 3178.7 3214.2 5615.7 5637.8 5641.2 5643.6 5653.0 6113.7 6119.1 6132.6 6141.7 6145.9 5506.9 5622.9 5638.8 5642.5 5649.1 5883.8 5896.4 5935.0 5991.9 5998.5 5839.5 5843.7 5844.9 5848.9 5851.6 5554.9 5656.1 5659.7 5666.0 5667.7 4180.9 4235.8 4238.5 4239.0 4241.8 5913.8 5915.6 5916.2 5919.4 5922.0 5671.8 5676.1 5683.0 5683.7 5689.2 5522.6 5666.8 5672.1 5674.9 5686.0 5555.5 5558.1 5560.2 5561.6 5561.9 5645.9 5695.9 5711.4 5713.4 5720.2 5478.9 5566.3 5571.7 5575.1 5583.3 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: 16:55:55 INFO - 2015-11-21 16:55:55,404 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12470.80 Median:45649.20 stddev:14209.35 (31.1%) stddev-sans-first:14221.44 16:55:55 INFO - 2015-11-21 16:55:55,406 DEBUG : BROWSER_OUTPUT: Values: 641.4 768.6 776.9 786.2 805.5 10639.5 10857.3 10858.4 10870.6 10890.1 11707.8 13500.9 13812.2 13821.4 13833.2 621.9 628.9 792.6 808.9 809.7 629.2 801.6 809.0 816.4 816.7 833.3 847.7 848.1 848.6 849.2 652.6 659.6 818.7 843.3 843.5 614.8 615.4 615.7 615.9 616.4 11568.8 11692.8 11703.4 11707.1 11724.2 10303.6 11182.7 11184.7 11438.9 11528.4 9116.0 9197.9 9211.4 9250.4 9333.4 3237.5 3250.6 3256.6 3281.6 3282.7 41147.2 41389.8 41400.8 41490.4 41568.6 8818.1 8986.1 9379.0 9380.9 9460.8 15933.8 15946.8 15949.8 15964.7 15974.8 6588.0 6640.4 6651.9 6702.1 6921.7 3629.8 3653.7 3726.9 3747.6 3778.1 2825.5 2857.7 2860.4 2863.6 2868.4 497.8 498.9 500.5 502.1 503.6 490.8 531.8 597.5 614.5 626.8 7930.5 7973.3 7975.7 8019.2 8160.8 605.9 624.5 632.7 637.0 643.9 3637.9 3890.2 3903.9 3977.2 4021.1 51222.7 51251.2 51386.0 51423.5 51871.2 44874.1 45248.1 45510.1 45788.3 45813.8 41978.8 42048.0 42681.8 42932.8 43386.0 7654.9 7711.8 7761.4 7884.2 7960.9 32144.8 32704.2 32868.3 33074.8 33367.0 38536.4 39262.6 39808.2 39855.4 39940.6 10744.7 10765.4 10877.4 10951.1 11090.7 11485.8 11510.6 11516.2 11520.4 11559.5 10475.2 10766.7 10802.9 10812.5 11439.4 10458.6 10607.2 10702.6 10773.4 11028.7 7694.3 9797.4 10341.1 10424.1 10542.8 8822.3 8871.5 8900.7 9014.2 9606.2 8962.5 9252.6 9263.8 9272.4 9351.8 16:55:55 INFO - 2015-11-21 16:55:55,406 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:55:55 INFO - 2015-11-21 16:55:55,406 DEBUG : BROWSER_OUTPUT: 16:55:56 INFO - 2015-11-21 16:55:56,113 INFO : Browser exited with error code: 0 16:55:56 INFO - 2015-11-21 16:55:56,134 INFO : Completed test dromaeo_css (00:18:38) 16:55:56 INFO - 2015-11-21 16:55:56,135 INFO : Starting test kraken 16:55:56 INFO - 2015-11-21 16:55:56,135 DEBUG : operating with platform_type : linux_ 16:55:56 INFO - 2015-11-21 16:55:56,135 INFO : Initialising browser for kraken test... 16:55:56 INFO - 2015-11-21 16:55:56,141 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSb4f7/profile http://localhost:56463/getInfo.html 16:56:00 INFO - 2015-11-21 16:56:00,020 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:56:00 INFO - 2015-11-21 16:56:00,020 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:56:00 INFO - 2015-11-21 16:56:00,020 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:56:00 INFO - 2015-11-21 16:56:00,021 DEBUG : BROWSER_OUTPUT: __metrics 16:56:00 INFO - 2015-11-21 16:56:00,097 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:56:01 INFO - 2015-11-21 16:56:01,145 INFO : Browser initialized. 16:56:01 INFO - 2015-11-21 16:56:01,146 INFO : Running cycle 1/1 for kraken test... 16:56:01 INFO - 2015-11-21 16:56:01,146 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTSb4f7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:56:13 INFO - 2015-11-21 16:56:13,035 DEBUG : BROWSER_OUTPUT: RSS: Main: 142241792 16:56:13 INFO - 2015-11-21 16:56:13,036 DEBUG : BROWSER_OUTPUT: 16:56:15 INFO - 2015-11-21 16:56:15,672 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56463/tests/kraken/driver.html?testName=audio-beat-detection) 16:56:16 INFO - 2015-11-21 16:56:16,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 176926720 16:56:16 INFO - 2015-11-21 16:56:16,258 DEBUG : BROWSER_OUTPUT: 16:56:18 INFO - 2015-11-21 16:56:18,975 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56463/tests/kraken/driver.html?testName=audio-dft) 16:56:19 INFO - 2015-11-21 16:56:19,544 DEBUG : BROWSER_OUTPUT: RSS: Main: 167272448 16:56:19 INFO - 2015-11-21 16:56:19,545 DEBUG : BROWSER_OUTPUT: 16:56:22 INFO - 2015-11-21 16:56:22,571 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56463/tests/kraken/driver.html?testName=audio-fft) 16:56:23 INFO - 2015-11-21 16:56:23,136 DEBUG : BROWSER_OUTPUT: RSS: Main: 152731648 16:56:23 INFO - 2015-11-21 16:56:23,137 DEBUG : BROWSER_OUTPUT: 16:56:25 INFO - 2015-11-21 16:56:25,174 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56463/tests/kraken/driver.html?testName=audio-oscillator) 16:56:25 INFO - 2015-11-21 16:56:25,743 DEBUG : BROWSER_OUTPUT: RSS: Main: 153759744 16:56:25 INFO - 2015-11-21 16:56:25,743 DEBUG : BROWSER_OUTPUT: 16:56:27 INFO - 2015-11-21 16:56:27,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56463/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:56:28 INFO - 2015-11-21 16:56:28,509 DEBUG : BROWSER_OUTPUT: RSS: Main: 155398144 16:56:28 INFO - 2015-11-21 16:56:28,510 DEBUG : BROWSER_OUTPUT: 16:56:31 INFO - 2015-11-21 16:56:31,522 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56463/tests/kraken/driver.html?testName=imaging-darkroom) 16:56:32 INFO - 2015-11-21 16:56:32,095 DEBUG : BROWSER_OUTPUT: RSS: Main: 155996160 16:56:32 INFO - 2015-11-21 16:56:32,095 DEBUG : BROWSER_OUTPUT: 16:56:35 INFO - 2015-11-21 16:56:35,477 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56463/tests/kraken/driver.html?testName=imaging-desaturate) 16:56:36 INFO - 2015-11-21 16:56:36,052 DEBUG : BROWSER_OUTPUT: RSS: Main: 158052352 16:56:36 INFO - 2015-11-21 16:56:36,052 DEBUG : BROWSER_OUTPUT: 16:56:38 INFO - 2015-11-21 16:56:38,891 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56463/tests/kraken/driver.html?testName=json-parse-financial) 16:56:39 INFO - 2015-11-21 16:56:39,464 DEBUG : BROWSER_OUTPUT: RSS: Main: 157421568 16:56:39 INFO - 2015-11-21 16:56:39,464 DEBUG : BROWSER_OUTPUT: 16:56:41 INFO - 2015-11-21 16:56:41,198 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56463/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:56:41 INFO - 2015-11-21 16:56:41,763 DEBUG : BROWSER_OUTPUT: RSS: Main: 164569088 16:56:41 INFO - 2015-11-21 16:56:41,764 DEBUG : BROWSER_OUTPUT: 16:56:43 INFO - 2015-11-21 16:56:43,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:56:44 INFO - 2015-11-21 16:56:44,239 DEBUG : BROWSER_OUTPUT: RSS: Main: 165343232 16:56:44 INFO - 2015-11-21 16:56:44,239 DEBUG : BROWSER_OUTPUT: 16:56:46 INFO - 2015-11-21 16:56:46,344 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:56:46 INFO - 2015-11-21 16:56:46,925 DEBUG : BROWSER_OUTPUT: RSS: Main: 172388352 16:56:46 INFO - 2015-11-21 16:56:46,925 DEBUG : BROWSER_OUTPUT: 16:56:49 INFO - 2015-11-21 16:56:49,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:56:50 INFO - 2015-11-21 16:56:50,001 DEBUG : BROWSER_OUTPUT: RSS: Main: 178716672 16:56:50 INFO - 2015-11-21 16:56:50,002 DEBUG : BROWSER_OUTPUT: 16:56:52 INFO - 2015-11-21 16:56:52,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:56:53 INFO - 2015-11-21 16:56:53,210 DEBUG : BROWSER_OUTPUT: RSS: Main: 179445760 16:56:53 INFO - 2015-11-21 16:56:53,211 DEBUG : BROWSER_OUTPUT: 16:56:54 INFO - 2015-11-21 16:56:54,959 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56463/tests/kraken/driver.html?testName=ai-astar) 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: RSS: Main: 236748800 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:56:55 INFO - 2015-11-21 16:56:55,217 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;113;108;112;113;111;101;113;111;111 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;134;150;169;138;160;154;132;165;129 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;162;162;159;161;162;165;160;166;164 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;93;71;73;74;118;90;73 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;93;92;128;91;91;91;126;91;92;130 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;109;110;109;109;109;109 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;146;146;146;146;147;147;146;147 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;95;95;96;95;95;95;95 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;70;71;70;70;70;69;78;67;67 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;67;69;68;69;69;68;68;69;68 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;83;83;84;84;82;82;84;84;82 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;127;119;119;117;127;130;123;130;124;120 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;138;150;149;151;148;159;146;146;148 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;68;68;68;68;69;68;68;68 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:56:55 INFO - 2015-11-21 16:56:55,218 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:56:55 INFO - 2015-11-21 16:56:55,219 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,957 16:56:55 INFO - 2015-11-21 16:56:55,219 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:56:55 INFO - 2015-11-21 16:56:55,219 DEBUG : BROWSER_OUTPUT: __startTimestamp1448153815212__endTimestamp 16:56:55 INFO - 2015-11-21 16:56:55,219 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.20 Median:111.50 stddev:3.65 (3.3%) stddev-sans-first:3.84 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: Values: 109.0 113.0 108.0 112.0 113.0 111.0 101.0 113.0 111.0 111.0 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.30 Median:153.00 stddev:14.31 (9.4%) stddev-sans-first:15.11 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: Values: 152.0 134.0 150.0 169.0 138.0 160.0 154.0 132.0 165.0 129.0 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,220 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.50 Median:163.00 stddev:2.22 (1.4%) stddev-sans-first:2.29 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: Values: 164.0 162.0 162.0 159.0 161.0 162.0 165.0 160.0 166.0 164.0 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.80 Median:73.50 stddev:14.88 (20.2%) stddev-sans-first:15.44 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 93.0 71.0 73.0 74.0 118.0 90.0 73.0 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.50 Median:91.00 stddev:17.63 (19.4%) stddev-sans-first:18.37 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: Values: 93.0 92.0 128.0 91.0 91.0 91.0 126.0 91.0 92.0 130.0 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.50 Median:110.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 109.0 110.0 109.0 109.0 109.0 109.0 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.50 Median:147.00 stddev:0.53 (0.4%) stddev-sans-first:0.53 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 146.0 146.0 146.0 146.0 147.0 147.0 146.0 147.0 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,221 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.40 Median:95.50 stddev:0.52 (0.5%) stddev-sans-first:0.50 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 95.0 95.0 96.0 95.0 95.0 95.0 95.0 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:3.05 (4.4%) stddev-sans-first:3.23 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 70.0 70.0 71.0 70.0 70.0 70.0 69.0 78.0 67.0 67.0 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:68.50 stddev:0.67 (1.0%) stddev-sans-first:0.71 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 68.0 67.0 69.0 68.0 69.0 69.0 68.0 68.0 69.0 68.0 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.90 Median:83.50 stddev:1.10 (1.3%) stddev-sans-first:0.93 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 81.0 83.0 83.0 84.0 84.0 82.0 82.0 84.0 84.0 82.0 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.50 stddev:4.77 (3.8%) stddev-sans-first:4.89 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 127.0 119.0 119.0 117.0 127.0 130.0 123.0 130.0 124.0 120.0 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.30 Median:148.50 stddev:5.19 (3.5%) stddev-sans-first:5.50 16:56:55 INFO - 2015-11-21 16:56:55,222 DEBUG : BROWSER_OUTPUT: Values: 148.0 138.0 150.0 149.0 151.0 148.0 159.0 146.0 146.0 148.0 16:56:55 INFO - 2015-11-21 16:56:55,223 DEBUG : BROWSER_OUTPUT: 16:56:55 INFO - 2015-11-21 16:56:55,223 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:68.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 16:56:55 INFO - 2015-11-21 16:56:55,223 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 68.0 68.0 68.0 68.0 69.0 68.0 68.0 68.0 16:56:55 INFO - 2015-11-21 16:56:55,223 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:56:55 INFO - 2015-11-21 16:56:55,223 DEBUG : BROWSER_OUTPUT: 16:56:56 INFO - 2015-11-21 16:56:56,133 INFO : Browser exited with error code: 0 16:56:56 INFO - 2015-11-21 16:56:56,182 INFO : Completed test kraken (00:01:00) 16:56:56 INFO - 2015-11-21 16:56:56,182 INFO : Starting test v8_7 16:56:56 INFO - 2015-11-21 16:56:56,182 DEBUG : operating with platform_type : linux_ 16:56:56 INFO - 2015-11-21 16:56:56,182 INFO : Initialising browser for v8_7 test... 16:56:56 INFO - 2015-11-21 16:56:56,188 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIbOmE/profile http://localhost:56463/getInfo.html 16:57:00 INFO - 2015-11-21 16:57:00,223 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:57:00 INFO - 2015-11-21 16:57:00,223 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:57:00 INFO - 2015-11-21 16:57:00,223 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:57:00 INFO - 2015-11-21 16:57:00,223 DEBUG : BROWSER_OUTPUT: __metrics 16:57:00 INFO - 2015-11-21 16:57:00,385 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:57:01 INFO - 2015-11-21 16:57:01,507 INFO : Browser initialized. 16:57:01 INFO - 2015-11-21 16:57:01,508 INFO : Running cycle 1/1 for v8_7 test... 16:57:01 INFO - 2015-11-21 16:57:01,508 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpnIbOmE/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:57:13 INFO - 2015-11-21 16:57:13,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 142311424 16:57:13 INFO - 2015-11-21 16:57:13,462 DEBUG : BROWSER_OUTPUT: 16:57:34 INFO - 2015-11-21 16:57:34,894 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:56463/tests/v8_7/run.html (next: http://localhost:56463/tests/v8_7/run.html) 16:57:35 INFO - 2015-11-21 16:57:35,152 DEBUG : BROWSER_OUTPUT: RSS: Main: 436854784 16:57:35 INFO - 2015-11-21 16:57:35,152 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,152 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:57:35 INFO - 2015-11-21 16:57:35,152 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:57:35 INFO - 2015-11-21 16:57:35,152 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |0;Richards;162.78691193228065 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.35093761959433 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.4076557697681 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5035.175879396985 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1972.3865877712033 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |5;Earley;784.4827586206897 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |6;Boyer;12219.512195121952 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |8;Splay;604.6790641871626 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4835.748792270531 16:57:35 INFO - 2015-11-21 16:57:35,153 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: __startTimestamp1448153855146__endTimestamp 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:162.79 Median:162.79 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: Values: 162.8 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.35 Median:191.35 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,154 DEBUG : BROWSER_OUTPUT: Values: 191.4 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.41 Median:279.41 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: Values: 279.4 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5035.18 Median:5035.18 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: Values: 5035.2 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1972.39 Median:1972.39 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: Values: 1972.4 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.48 Median:784.48 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,155 DEBUG : BROWSER_OUTPUT: Values: 784.5 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12219.51 Median:12219.51 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: Values: 12219.5 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: Values: 26025.6 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:604.68 Median:604.68 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: Values: 604.7 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4835.75 Median:4835.75 stddev:0.00 (0.0%) 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: Values: 4835.7 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:57:35 INFO - 2015-11-21 16:57:35,156 DEBUG : BROWSER_OUTPUT: 16:57:36 INFO - 2015-11-21 16:57:36,009 INFO : Browser exited with error code: 0 16:57:36 INFO - 2015-11-21 16:57:36,021 INFO : Completed test v8_7 (00:00:39) 16:57:36 INFO - 2015-11-21 16:57:36,170 INFO : Completed test suite (00:20:18) 16:57:36 INFO - 2015-11-21 16:57:36,170 DEBUG : Working with test: dromaeo_css 16:57:36 INFO - 2015-11-21 16:57:36,171 DEBUG : Generating results file: dromaeo_css 16:57:36 INFO - 2015-11-21 16:57:36,172 DEBUG : Working with test: kraken 16:57:36 INFO - 2015-11-21 16:57:36,172 DEBUG : Generating results file: kraken 16:57:36 INFO - 2015-11-21 16:57:36,172 INFO : javascript benchmark 16:57:36 INFO - 2015-11-21 16:57:36,172 DEBUG : Working with test: v8_7 16:57:36 INFO - 2015-11-21 16:57:36,172 DEBUG : Generating results file: v8_7 16:57:36 INFO - 2015-11-21 16:57:36,173 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:36 INFO - 2015-11-21 16:57:36,304 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 16:57:36 INFO - 2015-11-21 16:57:36,304 DEBUG : process_Request line: dromaeo_css 6391.45 graph.html#tests=[[72,203,35]] 16:57:36 INFO - 2015-11-21 16:57:36,304 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:36 INFO - 2015-11-21 16:57:36,415 DEBUG : process_Request line: kraken 1518.30 graph.html#tests=[[232,203,35]] 16:57:36 INFO - 2015-11-21 16:57:36,415 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:57:36 INFO - 2015-11-21 16:57:36,521 DEBUG : process_Request line: v8_7 19925.55 graph.html#tests=[[230,203,35]] 16:57:36 INFO - 2015-11-21 16:57:36,522 INFO : javascript benchmark 16:57:36 INFO - 2015-11-21 16:57:36,526 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2653.1377302376727, 2697.9325516862086, 2723.4008518126006, 2734.753872151506, 2754.3389586499247, 4504.842330518432, 4634.6292296616275, 4661.30080487927, 4680.953190468094, 4698.060387922416, 4673.0, 4712.528747125286, 4785.258284965836, 4795.808167673297, 4803.783829727662, 4254.936175957363, 4282.164977829325, 4389.38548603195, 4407.338899165119, 4407.801648925806, 4169.291220492523, 4339.674524410666, 4378.737275763465, 4401.845935392262, 4459.977700111495, 4153.771542565158, 4241.936370954438, 4249.065205654751, 4253.043065310296, 4267.722598031118, 4336.848210312655, 4358.411614432042, 4362.192994296033, 4403.515613282536, 4406.49325327585, 4138.8344466221315, 4336.544662810423, 4345.869623911288, 4354.433923589945, 4390.846320378771, 4479.037007043468, 4488.977555112204, 4525.660575456854, 4635.559621835921, 4680.461746899082, 5070.797168113271, 5073.7209453480045, 5076.923846142274, 5090.160123579605, 5130.769115389817, 4747.786349614275, 5114.539691427753, 5117.232415137722, 5118.897622047538, 5120.846374608767, 4604.746738929358, 4621.468531118964, 4715.83494577695, 4780.928286075712, 4839.177339852234, 5135.38375394955, 5137.794488220429, 5140.485951404829, 5140.871478213075, 5188.8443346698905, 4939.234418665113, 4945.851624451272, 4949.727764972961, 4954.232094025432, 4985.177445721488, 4795.712257264575, 4898.8775280618265, 4901.215805471107, 4906.95093049065, 5039.622028347889, 4924.60603151747, 5047.116754568009, 5065.037642847848, 5082.593392528589, 5096.439391666913, 5035.420926593489, 5044.319016932741, 5052.9242061369105, 5062.594992400599, 5099.6175286852895, 4006.4991876015497, 4212.094399704079, 4256.531781504032, 4258.957410425918, 4304.655627549789, 3637.690796282293, 3696.5748938871834, 3702.018964974284, 3733.533308336458, 3738.476613274144, 4320.330348795942, 4325.718828276152, 4332.631726303236, 4339.522652508222, 4402.3176407656865, 4716.3868697069165, 4982.402111746614, 4983.551480366785, 4987.825426110068, 5002.549770520671, 4263.211305908417, 4277.550857159953, 4297.140571885635, 4332.826686932487, 4340.348947657877, 4468.106378724268, 4471.172833025836, 4476.194285028726, 4483.641308695296, 4502.977485112553, 4545.681802273809, 4797.496262892346, 4799.880002999953, 4803.855884323476, 4839.830605928775, 4982.775775090202, 4986.700797952134, 5009.248612708123, 5091.745412729423, 5130.281760553451, 4782.569568738831, 4808.711477311373, 4815.518448155157, 4821.951780482291, 4873.707577545359, 4720.858374248778, 4986.526280003394, 5010.87472813168, 5013.448520662797, 5058.797648094035, 4930.038642464685, 4936.0, 4951.158303088411, 5023.397192336943, 5024.221245706921, 4869.220924652039, 4871.123197824426, 4873.805047798049, 4882.048000639841, 4916.557509824133, 4655.813767449264, 4902.411710594752, 4906.092372911023, 4908.484609116134, 4965.4289756678445, 4566.223741963808, 4631.351610774562, 4637.489876113692, 4647.512011238907, 4706.058788242297, 4951.306817045688, 4961.8511444656715, 4965.106280869334, 4966.205407134841, 5000.57495112905, 4604.631629469702, 4863.10032643962, 4868.537488938545, 4870.756462176806, 4901.828436004723], "unit": "ms", "name": "dojo.html", "value": 4605.167203753098}, {"lowerIsBetter": false, "replicates": [549.7086544131611, 572.6420986883198, 583.2825624481884, 587.4008511318456, 592.1177445606046, 28898.988535401266, 29695.703042969562, 38057.42913856291, 38541.614583854156, 38677.0, 41813.790931045376, 42303.0, 42394.364084538676, 42401.575984240146, 42465.78767106168, 6997.720091196346, 7866.763997080083, 8015.9178510900865, 8023.197680231989, 8023.719169829057, 7031.296870312954, 9757.756056098584, 9994.600215991351, 9999.700008999742, 10001.849972250386, 10038.14675752562, 10084.092431681147, 10099.848502272473, 10111.0, 10113.646022389217, 7263.3462988330775, 7451.0, 10241.590336386536, 10327.27709060366, 10362.481875906213, 9596.90403095974, 9715.90284097157, 9722.756931076708, 9731.075547822946, 9732.70801875945, 38751.418728719094, 39207.803960980295, 39297.607023929966, 39312.60687393118, 39386.60613393887, 2949.601803756487, 2952.070097919149, 2978.970210297891, 3041.7870749047574, 3543.20277937462, 28513.85743071292, 28674.713252867412, 29296.0, 29317.560236596255, 29625.40749185004, 3451.879184228565, 3485.721142308609, 3544.2379888323876, 3546.769459985093, 3599.7300202484657, 226350.0, 227394.0, 227836.0, 228169.0, 228727.99999999834, 51100.23349649758, 54206.45793542014, 54206.728966354916, 63417.68291158514, 64467.67766161139, 57900.4209957895, 57969.13046304309, 57976.4202357971, 58051.70974145102, 58134.7093264531, 12710.364481775874, 12879.034072444605, 12908.031897607718, 12915.354232288348, 12918.0, 9315.301352398597, 9362.953185234166, 9365.157135857806, 9427.858582121273, 9462.337636365388, 18905.90547047256, 19082.236710531422, 19278.32525861588, 19294.614107717767, 19311.51721206981, 7160.713571457188, 7359.484836061424, 7412.407007439392, 7412.55385722721, 7472.476926615193, 751.8609057324412, 826.5784449930578, 836.1053672570291, 850.8128211793396, 907.6460180529599, 26000.219993400227, 26062.73937260641, 26260.474790504464, 26351.0, 26476.338091547866, 922.377395258198, 935.854942483916, 944.9811003779886, 952.9237660987104, 963.4989805301344, 14275.42898284057, 14801.703965920622, 14821.25893705332, 15034.398624054915, 15051.623709407133, 270149.0, 275134.0, 275310.0, 275326.0, 275427.0, 47874.0, 48016.75991620089, 48120.518794812306, 48125.27812082751, 48162.759186203846, 1177.464253764535, 1228.0237211416766, 1244.7697176022284, 1249.2816630437353, 1262.223732404583, 26709.46581068329, 27617.447651046463, 27882.581761274003, 28309.292267693472, 28328.716712832607, 38084.428733568464, 41278.174436510504, 41687.1662566753, 41697.58302416937, 41725.0, 155646.0, 239063.0, 244063.0, 244074.0, 244725.0, 26678.333041674112, 27235.727642724112, 27302.590461143496, 27353.589696154973, 27363.179104626095, 36084.0, 39647.80176099101, 39863.20273594454, 40815.0, 40997.0, 30256.697433025387, 30333.69666303397, 30436.543451848684, 31414.05757827269, 31683.84158079195, 30738.231544210677, 31051.68948310488, 31064.534031989086, 31223.0, 31273.0, 30520.23699407444, 31255.687443125276, 31497.0, 31642.36715265728, 31655.366892661557, 27999.30001749891, 29199.7080029197, 29955.463790016718, 29987.850060749555, 30152.0, 23064.192753253556, 23854.52290954206, 25107.49785004253, 25415.6187657189, 25669.486610268064], "unit": "ms", "name": "ext.html", "value": 17139.03062031308}, {"lowerIsBetter": false, "replicates": [335.21057908625204, 337.65896444590953, 342.5238917904113, 343.5070673583408, 344.6897791987212, 12061.45723442445, 12456.252624842517, 15104.697906041873, 15152.318145683443, 15743.055416674993, 12091.395430228496, 14384.496542621011, 14914.701705965874, 15497.380104795822, 15502.922485387586, 4847.757612119406, 4919.917618124007, 4987.177115775893, 5041.588355260533, 5045.596352291808, 3282.9015129546033, 3381.171612954817, 4981.078500477405, 6470.644114573696, 6709.597424154542, 6457.8708425831455, 6628.801135965929, 6630.071789949411, 6683.097781799468, 6692.263850976388, 6612.70242839071, 6629.701663425158, 6633.568818026837, 6642.103316052319, 6648.833779155511, 5892.911606325909, 6117.84705382369, 6124.2957059938235, 6338.651374174418, 6342.207224096988, 18711.625767484573, 18876.81123188778, 19014.71477927832, 19213.903930480257, 19253.807461925342, 1859.618778150476, 1995.4013795861329, 2011.306099395706, 2014.1540552967788, 2056.7223424837753, 12860.164089334163, 12908.290044047573, 12920.612381628565, 12992.350382480838, 13225.338733063309, 1824.5712257619448, 1829.3688677406274, 1870.653929023135, 1920.4238728381429, 1967.8819270843794, 51318.48681513174, 53316.0, 55656.0, 56227.43772562304, 56904.43095569074, 14648.460893520114, 15320.23398830054, 15359.923200383926, 15426.228688565527, 15703.842961570239, 22551.32346029622, 22735.317940461813, 22839.20062797794, 22852.0, 22869.313920582408, 7733.7679869604, 7737.729179478803, 7758.9137520747145, 7759.7672069838, 7809.921900781033, 6232.034034724625, 6252.030935205051, 6262.15460912771, 6269.843253918597, 6313.589616674902, 6683.796916554969, 7625.961870190725, 7643.515857346385, 7660.655270512841, 7661.578613176329, 1770.6812773700858, 1777.4578753480312, 1784.3933062758724, 1793.0944872839132, 2237.5636750833755, 399.57445320733325, 403.61858044148585, 863.2360361080489, 915.7802127489488, 971.0968799016982, 9344.813103737888, 10100.949495252476, 11648.009919156797, 14354.425822967174, 14523.85476145225, 798.1858504325671, 838.5429940682343, 848.4357901995104, 858.536390349217, 873.1661263493348, 8179.141190174946, 8798.604062817189, 8931.508767017747, 8963.252165827731, 9057.731917531552, 492560.0, 498668.0, 512080.0, 512590.0, 518491.0, 67475.32524674789, 68273.31726682669, 70097.0, 70337.64831175811, 70812.0, 1084.2301965604508, 1089.5696200001114, 1095.9342439453658, 1104.6851647280487, 1108.7505311304892, 13893.722125557635, 13941.930290348484, 14032.789508157182, 14068.859311407165, 14275.21486318221, 32542.51186232161, 32698.50952235766, 33154.33691326208, 33683.3263334727, 34060.0, 42282.0, 43399.34900976425, 43521.12957740764, 43535.56464435442, 47039.588812335685, 8471.66113355459, 8885.289176865706, 8913.064128266438, 8931.240844528287, 8947.015828259016, 10247.590096396061, 10316.43259620728, 14581.343839527035, 15703.528894133195, 15808.446704365751, 13038.739225215253, 13298.734025319633, 13379.464821407035, 13485.056046076681, 13891.305434728021, 10416.06255436984, 12202.694932626755, 12592.87407125917, 13207.933960330136, 13267.33663316811, 9645.035496450299, 10951.945240273748, 11893.702657433634, 12234.204776689487, 12666.240025598494, 8443.746687599381, 8545.444546104483, 8599.96800383958, 8605.483670979762, 8620.310375169845, 8282.461639993382, 9493.715188544355, 12087.576934807239, 12165.33090680021, 12296.139270251355], "unit": "ms", "name": "jquery.html", "value": 8667.176550657992}, {"lowerIsBetter": false, "replicates": [1397.3432486731233, 1646.1686848141687, 1675.4136052381668, 1700.3453670336917, 1713.700102482066, 5852.531797456204, 6342.33405492423, 6548.1814773153355, 6554.803355899318, 6567.244766851813, 6688.598684078958, 6775.0, 6817.488688348369, 6819.295176205948, 6836.863262734742, 2091.8744875307493, 2106.8735875847497, 2109.789021097893, 2115.079940226007, 2115.6614941609346, 2074.605824893273, 2095.6332641787626, 2096.360610013945, 2100.0864623888583, 2100.28590279305, 2041.9387418377473, 2079.4385515910694, 2090.247510896084, 2095.078165607136, 2096.3501314592527, 2061.4949337412354, 2065.2874758208395, 2075.138817390781, 2075.699023641571, 2077.2521892118825, 2047.0481226229874, 2047.1606641277006, 2088.2691058129685, 2089.2583132987725, 2091.8326533877407, 5700.087985922232, 5868.618539794899, 6750.426213771835, 6776.457883369319, 6782.966085169543, 3553.7690050146916, 3606.9278614427562, 4031.07285324377, 4156.314208155651, 4204.306289462235, 2732.3169207698074, 2743.6433263675594, 2783.4154827486254, 2789.0656630028966, 2827.0670678676192, 888.6800751729372, 908.5729707037682, 929.8419268724333, 938.2259635800492, 951.2295041016729, 9018.954905225497, 9070.682526111621, 9091.27269818413, 9094.545272736337, 9100.36297459178, 3912.139329347539, 3918.059665680273, 3974.841006359771, 3989.4414781930554, 3996.460477835455, 7887.2507111825435, 7940.523568585903, 7967.800804979922, 7970.322522585529, 7985.321247693895, 4147.129102888367, 4150.211459822624, 4159.688023398257, 4162.292410290258, 4163.02168990287, 3753.6809371203753, 3755.4742336072973, 3756.6806821420487, 3763.7929913854455, 3766.3408903441787, 3322.601287845474, 3323.7673362864366, 3335.982525329749, 3353.3963886500665, 3370.0732298617586, 1085.913126949842, 1103.150574057987, 1103.2938919091787, 1105.4362275239685, 1115.3976852499723, 933.7012156110115, 1000.6397696829135, 1138.823482360219, 1160.489384670742, 1164.4003338280793, 6426.839329016812, 6453.709583068773, 6480.384363485461, 6499.967500162469, 6505.056766768792, 1043.7181960870523, 1044.6970378590124, 1052.6841947415744, 1057.0486562094022, 1084.6745976207105, 4549.0, 5063.11395505785, 5098.5411312982005, 5111.105556527593, 5117.8720531987, 7039.788806335818, 7847.332976697045, 7939.404544659174, 7965.0, 7989.800254993672, 7870.094939081964, 8016.519008859487, 8048.5975701215875, 8049.074356448966, 8058.11360750317, 6177.660228687465, 6556.541042127005, 6562.146920900348, 6576.736930522821, 6582.210134783761, 6435.935640643534, 6444.13004244421, 6489.253735820253, 6492.837679058061, 6506.869862602627, 7162.319579639926, 7324.08448943882, 7409.518381305198, 7410.5183163094225, 7414.814629634302, 7207.207207207098, 7575.6969721210535, 7609.124950630749, 7645.388368930583, 7666.1950495199435, 6456.12842266288, 6513.185851768529, 6562.77030303937, 6589.6705164740615, 6593.3736295051895, 6590.670466476753, 6612.107365505787, 6625.509260416367, 6644.302348253364, 6657.1345725055435, 6194.163787888578, 6287.96856015717, 6305.621662700252, 6308.053791931247, 6369.8726025480155, 6092.725827337869, 6216.564840461125, 6256.812295631138, 6258.186435763321, 6378.298387177314, 6327.272363678052, 6374.58565193261, 6377.266614339411, 6381.93618063832, 6390.137331460193, 5546.112621980464, 5547.639403438763, 5575.9163612545035, 5590.692511911721, 5603.131514615241, 5957.940420595912, 5996.970015150071, 6037.698115094316, 6063.211782468251, 6073.089036644362], "unit": "ms", "name": "mootools.html", "value": 4020.1993902425065}, {"lowerIsBetter": false, "replicates": [309.61143764575456, 314.0406059488262, 316.6864803844195, 320.7321886225002, 322.3987263753101, 5270.0, 5434.239206511092, 5508.724563771805, 5522.447755224475, 5527.889442211153, 5278.392984806748, 5404.054290499166, 5412.891742165154, 5414.025475414423, 5426.9185962210595, 3974.880753577397, 4042.555318914932, 4071.674266058723, 4224.640905523034, 4244.4270023546815, 4134.193832202722, 4175.415441838145, 4193.329067349225, 4194.727342722728, 4203.285441474942, 4145.896352591194, 4155.66754659628, 4156.896077598054, 4157.3140431828715, 4162.1675664867, 3931.4495970564003, 4023.2154729827694, 4054.736442131252, 4075.7962101894786, 4120.876373708764, 3613.94579081314, 3616.3490571697084, 3646.08847788053, 3648.562172539312, 3661.4690869823994, 5155.690658560461, 5194.480551944813, 5201.921971170397, 5204.531592156686, 5210.843674689765, 4775.307580400857, 4778.092162489151, 4780.713157210544, 4781.306710526954, 4785.258284965836, 5510.9448905511235, 5638.830835074954, 5652.265205523297, 5680.829575112712, 5690.60165788395, 3971.4042893565907, 3973.165635216608, 3974.5826688197903, 3977.1449138435087, 3977.244323578511, 5919.5560332974765, 6005.39946005396, 6010.128531362928, 6012.398760123996, 6013.218281623361, 4071.185762847442, 4100.159467309194, 4104.261232978033, 4108.589141085868, 4112.09533902541, 4026.59734026595, 4161.313383291723, 4167.395727619539, 4169.6455801256625, 4175.707700460999, 4737.336772851803, 4772.5943294819635, 4773.594244489188, 4775.403074615673, 4776.617870570415, 5684.886302274014, 5695.914561281584, 5701.743421546041, 5703.885922281531, 5704.657720536781, 1442.596073099534, 1474.329180222996, 1476.372541669786, 1476.4758510728752, 1476.6898951220364, 986.5412583148727, 989.8069876374038, 992.538469611634, 994.8855881573567, 1014.4217795856291, 5012.198048312325, 5013.974930125326, 5025.246213067996, 5027.296178535008, 5030.421501527371, 5891.263592050994, 5909.0, 5922.230110085661, 5923.318818335861, 5935.258092738408, 5026.220935754964, 5026.421961474404, 5034.874128146753, 5039.3448851649055, 5039.395272567315, 3028.545718142252, 3071.3550154467366, 3174.349258402022, 3178.666240044808, 3214.2125179330747, 5615.691136987423, 5637.830865074055, 5641.2384328116, 5643.633163844337, 5653.038983372837, 6113.663748493876, 6119.051547010221, 6132.601380910227, 6141.723622437001, 6145.907811382833, 5506.889862202814, 5622.887542249132, 5638.774449022158, 5642.463965923231, 5649.06790379591, 5883.794067207627, 5896.380880007709, 5935.0, 5991.850203744942, 5998.4601385875485, 5839.5036421904615, 5843.707814609337, 5844.94155058444, 5848.912266315923, 5851.64890106595, 5554.944450555443, 5656.095024796013, 5659.660420374791, 5665.971670141623, 5667.716614169358, 4180.895477613084, 4235.767032813224, 4238.512571054245, 4239.0, 4241.787910604396, 5913.793017244376, 5915.615484993462, 5916.171735957056, 5919.4080591940465, 5922.0, 5671.829845104653, 5676.120201368794, 5683.0, 5683.744231509675, 5689.231953686365, 5522.6134170609275, 5666.773329066791, 5672.064109421899, 5674.943250567441, 5685.971570142288, 5555.472230138131, 5558.110702287615, 5560.249366335493, 5561.582881283839, 5561.944380556142, 5645.9153112702525, 5695.943040569541, 5711.371749107512, 5713.371529131875, 5720.199172115824, 5478.8904221914545, 5566.332040155207, 5571.721413929368, 5575.0522411191005, 5583.302087239095], "unit": "ms", "name": "prototype.html", "value": 4282.989998234742}, {"lowerIsBetter": false, "replicates": [641.3906788550877, 768.5657603454048, 776.9067711874576, 786.2216405758301, 805.5166899860081, 10639.468026598668, 10857.34855908644, 10858.402787846675, 10870.61952831651, 10890.128789696815, 11707.765844683101, 13500.932495337534, 13812.171269723824, 13821.37803798829, 13833.17000979942, 621.9004959206528, 628.8868003759321, 792.5957761541598, 808.8584497712906, 809.6761295481825, 629.1663545801808, 801.5631480842925, 809.0372456776447, 816.3591580609223, 816.7019038051099, 833.3416600885294, 847.7244895408986, 848.0586548930683, 848.6393282854793, 849.218718778722, 652.5856081388305, 659.630606860155, 818.6602559937619, 843.2579330189425, 843.4854738609444, 614.8155553333982, 615.3600255734032, 615.7383112177307, 615.8645098078416, 616.4328817487922, 11568.826467602992, 11692.766144677058, 11703.356315402649, 11707.121965852595, 11724.179307448481, 10303.587856485732, 11182.66452006441, 11184.720381990433, 11438.942805286004, 11528.423578821026, 9116.0, 9197.862032069525, 9211.447313161232, 9250.35247532673, 9333.393329433566, 3237.465818140004, 3250.6261779895376, 3256.560364350806, 3281.6390197078304, 3282.6881446262805, 41147.177056459004, 41389.793051034554, 41400.79299603483, 41490.37764433506, 41568.584314156775, 8818.118188181259, 8986.05646407131, 9378.95310523443, 9380.90619093814, 9460.810783784424, 15933.840661593467, 15946.840531594768, 15949.840501595068, 15964.680706385807, 15974.76037859433, 6588.0, 6640.369164929324, 6651.926752943489, 6702.128723266042, 6921.688524016431, 3629.7822130672243, 3653.725970552219, 3726.8509259629855, 3747.569029561581, 3778.112143646241, 2825.4914115459005, 2857.6856545780365, 2860.3707184419395, 2863.6134121893692, 2868.3689588290545, 497.8406909788905, 498.9151844186497, 500.47200203784627, 502.1488576862184, 503.5644167794831, 490.77914938277206, 531.7926008856549, 597.5010865927, 614.4991831657185, 626.786892456567, 7930.484518506279, 7973.322267607318, 7975.72084977023, 8019.15798841125, 8160.755177344689, 605.9242594675666, 624.4723208888482, 632.6836581709146, 636.9681515924185, 643.9066335381343, 3637.890863274106, 3890.2414029264587, 3903.902402439905, 3977.164795392942, 4021.1153546219784, 51222.743886281074, 51251.23123153156, 51386.0, 51423.48576514262, 51871.221931671054, 44874.10251794946, 45248.095038099054, 45510.08979820385, 45788.3131753024, 45813.77093114513, 41978.790106049884, 42048.0, 42681.78659106685, 42932.78533607374, 43385.99999999937, 7654.885176722242, 7711.845763084595, 7761.417893658111, 7884.174454518833, 7960.920390796249, 32144.83927580347, 32704.182395440304, 32868.34263314768, 33074.83462582672, 33367.0, 38536.42195367016, 39262.60737392589, 39808.20383592254, 39855.40216896691, 39940.60059399369, 10744.677659670222, 10765.407902565434, 10877.401742904216, 10951.069159121564, 11090.667279981613, 11485.82771258415, 11510.59712910044, 11516.19386642927, 11520.366379849189, 11559.479823407799, 10475.16198704117, 10766.676999690022, 10802.891971080502, 10812.45937703096, 11439.428028598702, 10458.58165673395, 10607.151427885596, 10702.571897124028, 10773.353598784099, 11028.724281893017, 7694.2687895223125, 9797.363171393836, 10341.069303762397, 10424.113950314308, 10542.841857371992, 8822.25010874083, 8871.467711937305, 8900.73297801067, 9014.18872301496, 9606.183474404754, 8962.507062111647, 9252.629894804402, 9263.814723705353, 9272.350935434455, 9351.766205844908], "unit": "ms", "name": "yui.html", "value": 5786.871856687243}], "name": "dromaeo_css", "value": 6391.445008763033}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 113.0, 108.0, 112.0, 113.0, 111.0, 101.0, 113.0, 111.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.2}, {"lowerIsBetter": true, "replicates": [152.0, 134.0, 150.0, 169.0, 138.0, 160.0, 154.0, 132.0, 165.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.3}, {"lowerIsBetter": true, "replicates": [164.0, 162.0, 162.0, 159.0, 161.0, 162.0, 165.0, 160.0, 166.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 162.5}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 80.0, 93.0, 71.0, 73.0, 74.0, 118.0, 90.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.8}, {"lowerIsBetter": true, "replicates": [93.0, 92.0, 128.0, 91.0, 91.0, 91.0, 126.0, 91.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.5}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.5}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 146.0, 146.0, 146.0, 146.0, 147.0, 147.0, 146.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.5}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 95.0, 95.0, 96.0, 95.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.4}, {"lowerIsBetter": true, "replicates": [70.0, 70.0, 71.0, 70.0, 70.0, 70.0, 69.0, 78.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [68.0, 67.0, 69.0, 68.0, 69.0, 69.0, 68.0, 68.0, 69.0, 68.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [81.0, 83.0, 83.0, 84.0, 84.0, 82.0, 82.0, 84.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.9}, {"lowerIsBetter": true, "replicates": [127.0, 119.0, 119.0, 117.0, 127.0, 130.0, 123.0, 130.0, 124.0, 120.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [148.0, 138.0, 150.0, 149.0, 151.0, 148.0, 159.0, 146.0, 146.0, 148.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.3}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 68.0, 68.0, 68.0, 68.0, 69.0, 68.0, 68.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1518.2999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [162.78691193228065], "unit": "score", "name": "Richards", "value": 216.86018600000003}, {"lowerIsBetter": false, "replicates": [191.35093761959433], "unit": "score", "name": "DeltaBlue", "value": 345.53266799999994}, {"lowerIsBetter": false, "replicates": [279.4076557697681], "unit": "score", "name": "Encrypt", "value": 952.6617989999997}, {"lowerIsBetter": false, "replicates": [5035.175879396985], "unit": "score", "name": "Decrypt", "value": 52.864290419161705}, {"lowerIsBetter": false, "replicates": [1972.3865877712033], "unit": "score", "name": "RayTrace", "value": 375.1744229999998}, {"lowerIsBetter": false, "replicates": [784.4827586206897], "unit": "score", "name": "Earley", "value": 849.5572307692306}, {"lowerIsBetter": false, "replicates": [12219.512195121952], "unit": "score", "name": "Boyer", "value": 54.540884231536886}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [604.6790641871626], "unit": "score", "name": "Splay", "value": 134.76735813492058}, {"lowerIsBetter": false, "replicates": [4835.748792270531], "unit": "score", "name": "NavierStokes", "value": 306.881118881119}], "name": "v8_7", "value": 19925.5498116007}]} 16:57:36 INFO - RETURN: dromaeo_css: 6391.45 16:57:36 INFO - RETURN: kraken: 1518.30 16:57:36 INFO - RETURN: v8_7: 19925.55 16:57:36 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19925.55"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1518.30"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6391.45"}}} 16:57:36 INFO - Return code: 0 16:57:36 INFO - # TBPL SUCCESS # 16:57:36 INFO - Running post-action listener: _resource_record_post_action 16:57:36 INFO - Running post-run listener: _resource_record_post_run 16:57:37 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 86016; Write bytes: 510971904; Read time: 184; Write time: 470904 16:57:37 INFO - install - Wall time: 15s; CPU: 14.0%; Read bytes: 0; Write bytes: 165564416; Read time: 0; Write time: 245860 16:57:37 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 81920; Write bytes: 345395200; Read time: 176; Write time: 225044 16:57:37 INFO - Running post-run listener: _upload_blobber_files 16:57:37 INFO - Blob upload gear active. 16:57:37 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:57:37 INFO - Copying logs to upload dir... 16:57:37 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1262.676955 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2015-11-21 16:57:37.608001) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-21 16:57:37.611402) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.009959 build_url: 'https://queue.taskcluster.net/v1/task/pRofMxwLQEOHBdlBTHILog/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-21 16:57:37.663296) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:57:37.663662) ========= 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=edca6ca23558fe0608d91a4e00000196-1448152083.555566-1616639773 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004463 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-21 16:57:37.713672) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 16:57:37.714002) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-21 16:57:37.714319) ========= ========= Total master_lag: 0.23 =========