builder: b2g-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-049 starttime: 1448259753.22 results: success (0) buildid: 20151122215326 builduid: 7e0e4d46614341f891142ab703b8194a revision: f92df94073a3c3aca1b7b372c3a1fff843bbf127 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.223845) ========= master: http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.224547) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.225173) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006445 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.254342) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.254638) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.306448) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.306751) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004624 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.357128) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.357534) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.358051) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.358339) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-22 22:22:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org (hg.mozilla.org)... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 220M=0s 2015-11-22 22:22:33 (220 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.268889 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.639272) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.639571) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017620 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.688965) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:33.689319) ========= bash -c 'python archiver_client.py mozharness --repo integration/b2g-inbound --rev f92df94073a3c3aca1b7b372c3a1fff843bbf127 --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 f92df94073a3c3aca1b7b372c3a1fff843bbf127 --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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-22 22:22:34,004 truncating revision to first 12 chars 2015-11-22 22:22:34,004 Setting DEBUG logging. 2015-11-22 22:22:34,004 attempt 1/10 2015-11-22 22:22:34,004 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/b2g-inbound/f92df94073a3?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-22 22:22:34,278 unpacking tar archive at: b2g-inbound-f92df94073a3/testing/mozharness/ program finished with exit code 0 elapsedTime=0.542651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:34.247765) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:34.248239) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:34.261564) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:34.261927) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-22 22:22:34.262389) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-22 22:22:34.262672) ========= /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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 22:22:34 INFO - MultiFileLogger online at 20151122 22:22:34 in /builds/slave/test 22:22:34 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name B2G-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch B2G-Inbound-Non-PGO 22:22:34 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 22:22:34 INFO - {'append_to_log': False, 22:22:34 INFO - 'base_work_dir': '/builds/slave/test', 22:22:34 INFO - 'blob_upload_branch': 'B2G-Inbound-Non-PGO', 22:22:34 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 22:22:34 INFO - 'branch': 'B2G-Inbound-Non-PGO', 22:22:34 INFO - 'buildbot_json_path': 'buildprops.json', 22:22:34 INFO - 'config_files': ('talos/linux_config.py',), 22:22:34 INFO - 'default_actions': ('clobber', 22:22:34 INFO - 'read-buildbot-config', 22:22:34 INFO - 'download-and-extract', 22:22:34 INFO - 'populate-webroot', 22:22:34 INFO - 'create-virtualenv', 22:22:34 INFO - 'install', 22:22:34 INFO - 'run-tests'), 22:22:34 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 22:22:34 INFO - 'download_minidump_stackwalk': True, 22:22:34 INFO - 'download_symbols': 'ondemand', 22:22:34 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 22:22:34 INFO - 'tooltool.py': '/tools/tooltool.py', 22:22:34 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 22:22:34 INFO - '/tools/misc-python/virtualenv.py')}, 22:22:34 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 22:22:34 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 22:22:34 INFO - 'installer_path': 'installer.exe', 22:22:34 INFO - 'log_level': 'info', 22:22:34 INFO - 'log_name': 'talos', 22:22:34 INFO - 'log_to_console': True, 22:22:34 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 22:22:34 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 22:22:34 INFO - 'opt_config_files': (), 22:22:34 INFO - 'pip_index': False, 22:22:34 INFO - 'sps_profile': False, 22:22:34 INFO - 'sps_profile_interval': 0, 22:22:34 INFO - 'suite': 'dromaeojs', 22:22:34 INFO - 'system_bits': '64', 22:22:34 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 22:22:34 INFO - 'title': 'talos-linux64-ix-049', 22:22:34 INFO - 'tooltool_cache': '/builds/tooltool_cache', 22:22:34 INFO - 'use_talos_json': True, 22:22:34 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 22:22:34 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 22:22:34 INFO - 'work_dir': 'build'} 22:22:34 INFO - ##### 22:22:34 INFO - ##### Running clobber step. 22:22:34 INFO - ##### 22:22:34 INFO - Running pre-action listener: _resource_record_pre_action 22:22:34 INFO - Running main action method: clobber 22:22:34 INFO - rmtree: /builds/slave/test/build 22:22:34 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 22:22:35 INFO - Running post-action listener: _resource_record_post_action 22:22:35 INFO - ##### 22:22:35 INFO - ##### Running read-buildbot-config step. 22:22:35 INFO - ##### 22:22:35 INFO - Running pre-action listener: _resource_record_pre_action 22:22:35 INFO - Running main action method: read_buildbot_config 22:22:35 INFO - Using buildbot properties: 22:22:35 INFO - { 22:22:35 INFO - "properties": { 22:22:35 INFO - "buildnumber": 279, 22:22:35 INFO - "product": "firefox", 22:22:35 INFO - "script_repo_revision": "production", 22:22:35 INFO - "builddir": "b2g-inbound_ubuntu64_hw_test-dromaeojs", 22:22:35 INFO - "repository": "", 22:22:35 INFO - "buildername": "Ubuntu HW 12.04 x64 b2g-inbound talos dromaeojs", 22:22:35 INFO - "buildid": "20151122215326", 22:22:35 INFO - "slavename": "talos-linux64-ix-049", 22:22:35 INFO - "pgo_build": "False", 22:22:35 INFO - "basedir": "/builds/slave/test", 22:22:35 INFO - "project": "", 22:22:35 INFO - "platform": "ubuntu64_hw", 22:22:35 INFO - "master": "http://buildbot-master105.bb.releng.scl3.mozilla.com:8201/", 22:22:35 INFO - "slavebuilddir": "test", 22:22:35 INFO - "scheduler": "tests-b2g-inbound-linux64-talos", 22:22:35 INFO - "branch": "b2g-inbound", 22:22:35 INFO - "repo_path": "integration/b2g-inbound", 22:22:35 INFO - "stage_platform": "linux64", 22:22:35 INFO - "builduid": "7e0e4d46614341f891142ab703b8194a", 22:22:35 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 22:22:35 INFO - }, 22:22:35 INFO - "sourcestamp": { 22:22:35 INFO - "repository": "", 22:22:35 INFO - "hasPatch": false, 22:22:35 INFO - "project": "", 22:22:35 INFO - "branch": "b2g-inbound-linux64-talos", 22:22:35 INFO - "changes": [ 22:22:35 INFO - { 22:22:35 INFO - "category": null, 22:22:35 INFO - "files": [ 22:22:35 INFO - { 22:22:35 INFO - "url": null, 22:22:35 INFO - "name": "https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 22:22:35 INFO - } 22:22:35 INFO - ], 22:22:35 INFO - "repository": "", 22:22:35 INFO - "rev": "f92df94073a3c3aca1b7b372c3a1fff843bbf127", 22:22:35 INFO - "who": "btian@mozilla.com", 22:22:35 INFO - "when": 1448259720, 22:22:35 INFO - "number": 6694110, 22:22:35 INFO - "comments": "Bug 1225340 - Refine nullity check macros in BluetoothServiceBluedroid, r=tzimmermann", 22:22:35 INFO - "project": "", 22:22:35 INFO - "at": "Sun 22 Nov 2015 22:22:00", 22:22:35 INFO - "branch": "b2g-inbound-linux64-talos", 22:22:35 INFO - "revlink": "", 22:22:35 INFO - "properties": [ 22:22:35 INFO - [ 22:22:35 INFO - "buildid", 22:22:35 INFO - "20151122215326", 22:22:35 INFO - "Change" 22:22:35 INFO - ], 22:22:35 INFO - [ 22:22:35 INFO - "builduid", 22:22:35 INFO - "7e0e4d46614341f891142ab703b8194a", 22:22:35 INFO - "Change" 22:22:35 INFO - ], 22:22:35 INFO - [ 22:22:35 INFO - "pgo_build", 22:22:35 INFO - "False", 22:22:35 INFO - "Change" 22:22:35 INFO - ] 22:22:35 INFO - ], 22:22:35 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 22:22:35 INFO - } 22:22:35 INFO - ], 22:22:35 INFO - "revision": "f92df94073a3c3aca1b7b372c3a1fff843bbf127" 22:22:35 INFO - } 22:22:35 INFO - } 22:22:35 INFO - Found installer url https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 22:22:35 INFO - Running post-action listener: _resource_record_post_action 22:22:35 INFO - ##### 22:22:35 INFO - ##### Running download-and-extract step. 22:22:35 INFO - ##### 22:22:35 INFO - Running pre-action listener: _resource_record_pre_action 22:22:35 INFO - Running main action method: download_and_extract 22:22:35 INFO - mkdir: /builds/slave/test/build/tests 22:22: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')]} 22:22:35 INFO - https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 22:22:35 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/test_packages.json 22:22:35 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/test_packages.json 22:22:35 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 22:22:35 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 22:22:37 INFO - Downloaded 1302 bytes. 22:22:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 22:22:37 INFO - Using the following test package requirements: 22:22:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 22:22:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'jsshell-linux-x86_64.zip'], 22:22:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 22:22:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 22:22:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 22:22:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 22:22:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 22:22:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 22:22:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 22:22:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 22:22: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')]} 22:22:37 INFO - https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:39 INFO - Downloaded 21338691 bytes. 22:22:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:22:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:22:40 INFO - Return code: 0 22:22:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 22:22:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:40 INFO - https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 22:22:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'}, attempt #1 22:22:42 INFO - Downloaded 21338691 bytes. 22:22:42 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 22:22:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 22:22:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 22:22:43 INFO - Return code: 0 22:22:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:43 INFO - https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 22:22:43 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:43 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:43 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:22:43 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'}, attempt #1 22:22:44 INFO - Downloaded 11130997 bytes. 22:22: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 22:22:44 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 22:22: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 22:22:45 INFO - Return code: 0 22:22:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:45 INFO - https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 22:22:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:22:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:22:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 to /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:22:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2'}, attempt #1 22:22:46 INFO - Downloaded 55898936 bytes. 22:22:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:22:46 INFO - mkdir: /builds/slave/test/properties 22:22:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 22:22:46 INFO - Writing to file /builds/slave/test/properties/build_url 22:22:46 INFO - Contents: 22:22:46 INFO - build_url:https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 22:22:46 INFO - Running post-action listener: _resource_record_post_action 22:22:46 INFO - Running post-action listener: set_extra_try_arguments 22:22:46 INFO - ##### 22:22:46 INFO - ##### Running populate-webroot step. 22:22:46 INFO - ##### 22:22:46 INFO - Running pre-action listener: _resource_record_pre_action 22:22:46 INFO - Running main action method: populate_webroot 22:22:46 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 22:22:46 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 22:22:46 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 22:22:46 INFO - '../fennec_ids.txt'], 22:22:46 INFO - 'tests': ['tcheck2']}, 22:22:46 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 22:22:46 INFO - '--tppagecycles', 22:22:46 INFO - '7'], 22:22:46 INFO - 'tests': ['tsvgm']}}, 22:22:46 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 22:22:46 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['tresize', 'tcanvasmark']}, 22:22:46 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:22:46 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 22:22:46 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:46 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 22:22:46 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'tests': ['damp', 'tps']}, 22:22:46 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['damp', 'tps']}, 22:22:46 INFO - 'g3': {'tests': ['dromaeo_dom']}, 22:22:46 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 22:22:46 INFO - 'other': {'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'other-e10s': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'other_l64': {'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'other_nol64': {'tests': ['a11yr', 22:22:46 INFO - 'ts_paint', 22:22:46 INFO - 'tpaint', 22:22:46 INFO - 'sessionrestore', 22:22:46 INFO - 'sessionrestore_no_auto_restore']}, 22:22:46 INFO - 'svgr': {'tests': ['tsvgx', 22:22:46 INFO - 'tsvgr_opacity', 22:22:46 INFO - 'tart', 22:22:46 INFO - 'tscrollx', 22:22:46 INFO - 'cart']}, 22:22:46 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['tsvgx', 22:22:46 INFO - 'tsvgr_opacity', 22:22:46 INFO - 'tart', 22:22:46 INFO - 'tscrollx', 22:22:46 INFO - 'cart']}, 22:22:46 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'tests': ['tp5o']}, 22:22:46 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'talos_options': ['--e10s'], 22:22:46 INFO - 'tests': ['tp5o']}, 22:22:46 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'talos_options': ['--xperf_path', 22:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:46 INFO - 'tests': ['tp5n']}, 22:22:46 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 22:22:46 INFO - 'talos_options': ['--e10s', 22:22:46 INFO - '--xperf_path', 22:22:46 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 22:22:46 INFO - 'tests': ['tp5n']}}, 22:22:46 INFO - 'talos.zip': {'path': '', 22:22:46 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 22:22:46 INFO - Running post-action listener: _resource_record_post_action 22:22:46 INFO - ##### 22:22:46 INFO - ##### Running create-virtualenv step. 22:22:46 INFO - ##### 22:22:46 INFO - Running pre-action listener: _resource_record_pre_action 22:22:46 INFO - Running main action method: create_virtualenv 22:22:46 INFO - Creating virtualenv /builds/slave/test/build/venv 22:22:46 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 22:22:46 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 22:22:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 22:22:47 INFO - Using real prefix '/usr' 22:22:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 22:22:47 INFO - Installing distribute.............................................................................................................................................................................................done. 22:22:49 INFO - Installing pip.................done. 22:22:49 INFO - Return code: 0 22:22:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 22:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 22:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 22:22:49 INFO - Using env: {'DISPLAY': ':0', 22:22:49 INFO - 'HOME': '/home/cltbld', 22:22:49 INFO - 'LANG': 'en_US.UTF-8', 22:22:49 INFO - 'LANGUAGE': 'en_US:en', 22:22:49 INFO - 'LOGNAME': 'cltbld', 22:22:49 INFO - 'MAIL': '/var/mail/cltbld', 22:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:49 INFO - 'MOZ_NO_REMOTE': '1', 22:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:49 INFO - 'NO_EM_RESTART': '1', 22:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:49 INFO - 'PWD': '/builds/slave/test', 22:22:49 INFO - 'SHELL': '/bin/bash', 22:22:49 INFO - 'SHLVL': '1', 22:22:49 INFO - 'TERM': 'linux', 22:22:49 INFO - 'TMOUT': '86400', 22:22:49 INFO - 'USER': 'cltbld', 22:22:49 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:49 INFO - '_': '/tools/buildbot/bin/python'} 22:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 22:22:49 INFO - Cleaning up... 22:22:49 INFO - Return code: 0 22:22:49 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 22:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 22:22:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 22:22:49 INFO - Using env: {'DISPLAY': ':0', 22:22:49 INFO - 'HOME': '/home/cltbld', 22:22:49 INFO - 'LANG': 'en_US.UTF-8', 22:22:49 INFO - 'LANGUAGE': 'en_US:en', 22:22:49 INFO - 'LOGNAME': 'cltbld', 22:22:49 INFO - 'MAIL': '/var/mail/cltbld', 22:22:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:49 INFO - 'MOZ_NO_REMOTE': '1', 22:22:49 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:49 INFO - 'NO_EM_RESTART': '1', 22:22:49 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:49 INFO - 'PWD': '/builds/slave/test', 22:22:49 INFO - 'SHELL': '/bin/bash', 22:22:49 INFO - 'SHLVL': '1', 22:22:49 INFO - 'TERM': 'linux', 22:22:49 INFO - 'TMOUT': '86400', 22:22:49 INFO - 'USER': 'cltbld', 22:22:49 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:22:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:49 INFO - '_': '/tools/buildbot/bin/python'} 22:22:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:49 INFO - Downloading/unpacking psutil>=0.7.1 22:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:49 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:49 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:49 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:49 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:51 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 22:22:51 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 22:22:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 22:22:51 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:51 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:51 INFO - Installing collected packages: psutil 22:22:51 INFO - Running setup.py install for psutil 22:22:51 INFO - building 'psutil._psutil_linux' extension 22:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -DPSUTIL_VERSION=311 -I/usr/include/python2.7 -c psutil/_psutil_linux.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o 22:22:51 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_linux.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_linux.so 22:22:51 INFO - building 'psutil._psutil_posix' extension 22:22:51 INFO - gcc -pthread -fno-strict-aliasing -DNDEBUG -g -fwrapv -O2 -Wall -Wstrict-prototypes -fPIC -I/usr/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o 22:22:52 INFO - gcc -pthread -shared -Wl,-O1 -Wl,-Bsymbolic-functions -Wl,-Bsymbolic-functions -Wl,-z,relro build/temp.linux-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.linux-x86_64-2.7/psutil/_psutil_posix.so 22:22:52 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 22:22:52 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 22:22:52 INFO - Successfully installed psutil 22:22:52 INFO - Cleaning up... 22:22:52 INFO - Return code: 0 22:22:52 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 22:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:52 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 22:22:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 22:22:52 INFO - Using env: {'DISPLAY': ':0', 22:22:52 INFO - 'HOME': '/home/cltbld', 22:22:52 INFO - 'LANG': 'en_US.UTF-8', 22:22:52 INFO - 'LANGUAGE': 'en_US:en', 22:22:52 INFO - 'LOGNAME': 'cltbld', 22:22:52 INFO - 'MAIL': '/var/mail/cltbld', 22:22:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:52 INFO - 'MOZ_NO_REMOTE': '1', 22:22:52 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:52 INFO - 'NO_EM_RESTART': '1', 22:22:52 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:52 INFO - 'PWD': '/builds/slave/test', 22:22:52 INFO - 'SHELL': '/bin/bash', 22:22:52 INFO - 'SHLVL': '1', 22:22:52 INFO - 'TERM': 'linux', 22:22:52 INFO - 'TMOUT': '86400', 22:22:52 INFO - 'USER': 'cltbld', 22:22:52 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:22:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:52 INFO - '_': '/tools/buildbot/bin/python'} 22:22:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:52 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 22:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:52 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:52 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:52 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:52 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:54 INFO - Downloading mozsystemmonitor-0.0.tar.gz 22:22:54 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 22:22:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 22:22:54 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 22:22:54 INFO - Installing collected packages: mozsystemmonitor 22:22:54 INFO - Running setup.py install for mozsystemmonitor 22:22:54 INFO - Successfully installed mozsystemmonitor 22:22:54 INFO - Cleaning up... 22:22:54 INFO - Return code: 0 22:22:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 22:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 22:22:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 22:22:54 INFO - Using env: {'DISPLAY': ':0', 22:22:54 INFO - 'HOME': '/home/cltbld', 22:22:54 INFO - 'LANG': 'en_US.UTF-8', 22:22:54 INFO - 'LANGUAGE': 'en_US:en', 22:22:54 INFO - 'LOGNAME': 'cltbld', 22:22:54 INFO - 'MAIL': '/var/mail/cltbld', 22:22:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:54 INFO - 'MOZ_NO_REMOTE': '1', 22:22:54 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:54 INFO - 'NO_EM_RESTART': '1', 22:22:54 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:54 INFO - 'PWD': '/builds/slave/test', 22:22:54 INFO - 'SHELL': '/bin/bash', 22:22:54 INFO - 'SHLVL': '1', 22:22:54 INFO - 'TERM': 'linux', 22:22:54 INFO - 'TMOUT': '86400', 22:22:54 INFO - 'USER': 'cltbld', 22:22:54 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:22:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:54 INFO - '_': '/tools/buildbot/bin/python'} 22:22:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:54 INFO - Downloading/unpacking blobuploader==1.2.4 22:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:56 INFO - Downloading blobuploader-1.2.4.tar.gz 22:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 22:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 22:22:56 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 22:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 22:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 22:22:56 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 22:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:22:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:22:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:22:56 INFO - Downloading docopt-0.6.1.tar.gz 22:22:56 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 22:22:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 22:22:56 INFO - Installing collected packages: blobuploader, requests, docopt 22:22:56 INFO - Running setup.py install for blobuploader 22:22:56 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 22:22:56 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 22:22:56 INFO - Running setup.py install for requests 22:22:57 INFO - Running setup.py install for docopt 22:22:57 INFO - Successfully installed blobuploader requests docopt 22:22:57 INFO - Cleaning up... 22:22:57 INFO - Return code: 0 22:22:57 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:22:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:22:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:22:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:22:57 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:22:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:22:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:22:57 INFO - Using env: {'DISPLAY': ':0', 22:22:57 INFO - 'HOME': '/home/cltbld', 22:22:57 INFO - 'LANG': 'en_US.UTF-8', 22:22:57 INFO - 'LANGUAGE': 'en_US:en', 22:22:57 INFO - 'LOGNAME': 'cltbld', 22:22:57 INFO - 'MAIL': '/var/mail/cltbld', 22:22:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:22:57 INFO - 'MOZ_NO_REMOTE': '1', 22:22:57 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:22:57 INFO - 'NO_EM_RESTART': '1', 22:22:57 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:22:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:22:57 INFO - 'PWD': '/builds/slave/test', 22:22:57 INFO - 'SHELL': '/bin/bash', 22:22:57 INFO - 'SHLVL': '1', 22:22:57 INFO - 'TERM': 'linux', 22:22:57 INFO - 'TMOUT': '86400', 22:22:57 INFO - 'USER': 'cltbld', 22:22:57 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:22:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:22:57 INFO - '_': '/tools/buildbot/bin/python'} 22:22:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:22:57 INFO - Running setup.py (path:/tmp/pip-bFrz1v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:22:57 INFO - Running setup.py (path:/tmp/pip-hIUtFX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:22:57 INFO - Running setup.py (path:/tmp/pip-yR10lJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:22:57 INFO - Running setup.py (path:/tmp/pip-g5Gito-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:22:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:22:57 INFO - Running setup.py (path:/tmp/pip-lf5IZC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:22:58 INFO - Running setup.py (path:/tmp/pip-EiU2gC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:22:58 INFO - Running setup.py (path:/tmp/pip-E1yrop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:22:58 INFO - Running setup.py (path:/tmp/pip-ft88_A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:22:58 INFO - Running setup.py (path:/tmp/pip-62SBIX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:22:58 INFO - Running setup.py (path:/tmp/pip-20XOiw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:22:58 INFO - Running setup.py (path:/tmp/pip-gHR_J2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:22:58 INFO - Running setup.py (path:/tmp/pip-Wljh1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:22:58 INFO - Running setup.py (path:/tmp/pip-tyqVUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:22:58 INFO - Running setup.py (path:/tmp/pip-uLrnA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:58 INFO - Running setup.py (path:/tmp/pip-04Ejhw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:22:58 INFO - Running setup.py (path:/tmp/pip-sqzdcF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:22:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:22:58 INFO - Running setup.py (path:/tmp/pip-vnP6qb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:22:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 22:22:58 INFO - Running setup.py install for manifestparser 22:22:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 22:22:58 INFO - Running setup.py install for mozcrash 22:22:59 INFO - Running setup.py install for mozdebug 22:22:59 INFO - Running setup.py install for mozdevice 22:22:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Running setup.py install for mozfile 22:22:59 INFO - Running setup.py install for mozhttpd 22:22:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Running setup.py install for mozinfo 22:22:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Running setup.py install for mozInstall 22:22:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Running setup.py install for mozleak 22:22:59 INFO - Running setup.py install for mozlog 22:22:59 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 22:22:59 INFO - Running setup.py install for moznetwork 22:23:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Running setup.py install for mozprocess 22:23:00 INFO - Running setup.py install for mozprofile 22:23:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Running setup.py install for mozrunner 22:23:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Running setup.py install for mozscreenshot 22:23:00 INFO - Running setup.py install for moztest 22:23:00 INFO - Running setup.py install for mozversion 22:23:00 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 22:23:00 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 22:23:00 INFO - Cleaning up... 22:23:00 INFO - Return code: 0 22:23:00 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:00 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 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:23:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 22:23:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:23:00 INFO - Using env: {'DISPLAY': ':0', 22:23:00 INFO - 'HOME': '/home/cltbld', 22:23:00 INFO - 'LANG': 'en_US.UTF-8', 22:23:00 INFO - 'LANGUAGE': 'en_US:en', 22:23:00 INFO - 'LOGNAME': 'cltbld', 22:23:00 INFO - 'MAIL': '/var/mail/cltbld', 22:23:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:00 INFO - 'MOZ_NO_REMOTE': '1', 22:23:00 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:00 INFO - 'NO_EM_RESTART': '1', 22:23:00 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:00 INFO - 'PWD': '/builds/slave/test', 22:23:00 INFO - 'SHELL': '/bin/bash', 22:23:00 INFO - 'SHLVL': '1', 22:23:00 INFO - 'TERM': 'linux', 22:23:00 INFO - 'TMOUT': '86400', 22:23:00 INFO - 'USER': 'cltbld', 22:23:00 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:23:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:00 INFO - '_': '/tools/buildbot/bin/python'} 22:23:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 22:23:00 INFO - Running setup.py (path:/tmp/pip-mCNvQp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 22:23:00 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 22:23:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 22:23:00 INFO - Running setup.py (path:/tmp/pip-xjbks5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 22:23:01 INFO - Running setup.py (path:/tmp/pip-X_0j7J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 22:23:01 INFO - Running setup.py (path:/tmp/pip-irP5Yj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 22:23:01 INFO - Running setup.py (path:/tmp/pip-GsLz_8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 22:23:01 INFO - Running setup.py (path:/tmp/pip-dV0zz8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 22:23:01 INFO - Running setup.py (path:/tmp/pip-B17huB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 22:23:01 INFO - Running setup.py (path:/tmp/pip-x3IG8e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 22:23:01 INFO - Running setup.py (path:/tmp/pip-S22FpM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 22:23:01 INFO - Running setup.py (path:/tmp/pip-yPm7dC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 22:23:01 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)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 22:23:01 INFO - Running setup.py (path:/tmp/pip-Y9cEFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 22:23:01 INFO - Running setup.py (path:/tmp/pip-weIFcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 22:23:01 INFO - Running setup.py (path:/tmp/pip-SqYxz_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 22:23:01 INFO - Running setup.py (path:/tmp/pip-Zzn_qk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:01 INFO - Running setup.py (path:/tmp/pip-icoqog-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 22:23:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 22:23:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 22:23:01 INFO - Running setup.py (path:/tmp/pip-lOSGl1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 22:23:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 22:23:02 INFO - Running setup.py (path:/tmp/pip-trpBzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:23:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 22:23:02 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 22:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 22:23:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 22:23:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 22:23:03 INFO - Downloading blessings-1.5.1.tar.gz 22:23:03 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 22:23:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 22:23:03 INFO - Installing collected packages: blessings 22:23:03 INFO - Running setup.py install for blessings 22:23:03 INFO - Successfully installed blessings 22:23:03 INFO - Cleaning up... 22:23:04 INFO - Return code: 0 22:23:04 INFO - Done creating virtualenv /builds/slave/test/build/venv. 22:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:04 INFO - Reading from file tmpfile_stdout 22:23:04 INFO - Current package versions: 22:23:04 INFO - argparse == 1.2.1 22:23:04 INFO - blessings == 1.5.1 22:23:04 INFO - blobuploader == 1.2.4 22:23:04 INFO - docopt == 0.6.1 22:23:04 INFO - manifestparser == 1.1 22:23:04 INFO - mozInstall == 1.12 22:23:04 INFO - mozcrash == 0.16 22:23:04 INFO - mozdebug == 0.1 22:23:04 INFO - mozdevice == 0.47 22:23:04 INFO - mozfile == 1.2 22:23:04 INFO - mozhttpd == 0.7 22:23:04 INFO - mozinfo == 0.9 22:23:04 INFO - mozleak == 0.1 22:23:04 INFO - mozlog == 3.0 22:23:04 INFO - moznetwork == 0.27 22:23:04 INFO - mozprocess == 0.22 22:23:04 INFO - mozprofile == 0.27 22:23:04 INFO - mozrunner == 6.11 22:23:04 INFO - mozscreenshot == 0.1 22:23:04 INFO - mozsystemmonitor == 0.0 22:23:04 INFO - moztest == 0.7 22:23:04 INFO - mozversion == 1.4 22:23:04 INFO - psutil == 3.1.1 22:23:04 INFO - requests == 1.2.3 22:23:04 INFO - wsgiref == 0.1.2 22:23:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 22:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 22:23:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 22:23:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 22:23:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f51ca595c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x16786c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1729900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, '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': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 'LANGUAGE': 'en_US:en', 'MAIL': '/var/mail/cltbld', 'SHLVL': '1', 'XPCOM_DEBUG_BREAK': 'warn', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 'TMOUT': '86400', 'PWD': '/builds/slave/test', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 'NO_EM_RESTART': '1', 'HOME': '/home/cltbld', 'DISPLAY': ':0', '_': '/tools/buildbot/bin/python'}}, attempt #1 22:23:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 22:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 22:23:04 INFO - Using env: {'DISPLAY': ':0', 22:23:04 INFO - 'HOME': '/home/cltbld', 22:23:04 INFO - 'LANG': 'en_US.UTF-8', 22:23:04 INFO - 'LANGUAGE': 'en_US:en', 22:23:04 INFO - 'LOGNAME': 'cltbld', 22:23:04 INFO - 'MAIL': '/var/mail/cltbld', 22:23:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:04 INFO - 'MOZ_NO_REMOTE': '1', 22:23:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:04 INFO - 'NO_EM_RESTART': '1', 22:23:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:04 INFO - 'PWD': '/builds/slave/test', 22:23:04 INFO - 'SHELL': '/bin/bash', 22:23:04 INFO - 'SHLVL': '1', 22:23:04 INFO - 'TERM': 'linux', 22:23:04 INFO - 'TMOUT': '86400', 22:23:04 INFO - 'USER': 'cltbld', 22:23:04 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:23:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:04 INFO - '_': '/tools/buildbot/bin/python'} 22:23:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 22:23:04 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 22:23:04 INFO - Cleaning up... 22:23:04 INFO - Return code: 0 22:23:04 INFO - Running post-action listener: _resource_record_post_action 22:23:04 INFO - Running post-action listener: _start_resource_monitoring 22:23:04 INFO - Starting resource monitoring. 22:23:04 INFO - ##### 22:23:04 INFO - ##### Running install step. 22:23:04 INFO - ##### 22:23:04 INFO - Running pre-action listener: _resource_record_pre_action 22:23:04 INFO - Running main action method: install 22:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 22:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 22:23:04 INFO - Reading from file tmpfile_stdout 22:23:04 INFO - Detecting whether we're running mozinstall >=1.0... 22:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 22:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 22:23:04 INFO - Reading from file tmpfile_stdout 22:23:04 INFO - Output received: 22:23:04 INFO - Usage: mozinstall [options] installer 22:23:04 INFO - Options: 22:23:04 INFO - -h, --help show this help message and exit 22:23:04 INFO - -d DEST, --destination=DEST 22:23:04 INFO - Directory to install application into. [default: 22:23:04 INFO - "/builds/slave/test"] 22:23:04 INFO - --app=APP Application being installed. [default: firefox] 22:23:04 INFO - mkdir: /builds/slave/test/build/application 22:23:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2', '--destination', '/builds/slave/test/build/application'] 22:23:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 --destination /builds/slave/test/build/application 22:23:19 INFO - Reading from file tmpfile_stdout 22:23:19 INFO - Output received: 22:23:19 INFO - /builds/slave/test/build/application/firefox/firefox 22:23:19 INFO - Running post-action listener: _resource_record_post_action 22:23:19 INFO - ##### 22:23:19 INFO - ##### Running run-tests step. 22:23:19 INFO - ##### 22:23:19 INFO - Running pre-action listener: _resource_record_pre_action 22:23:19 INFO - Running main action method: run_tests 22:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 22:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 22:23:19 INFO - Python 2.7.3 22:23:19 INFO - Return code: 0 22:23:19 INFO - grabbing minidump binary from tooltool 22:23:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 22:23:19 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x176fb70>, '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 0x17c0dc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x17c1250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 22:23:19 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 22:23:19 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/linux64/releng.manifest -o -c /builds/tooltool_cache 22:23:19 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 22:23:19 INFO - Return code: 0 22:23:19 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 22:23:19 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 22:23:19 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 22:23:19 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 22:23:19 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 22:23:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] in /builds/slave/test/build 22:23:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName B2G-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-049 --webServer localhost 22:23:19 INFO - Using env: {'DISPLAY': ':0', 22:23:19 INFO - 'HOME': '/home/cltbld', 22:23:19 INFO - 'LANG': 'en_US.UTF-8', 22:23:19 INFO - 'LANGUAGE': 'en_US:en', 22:23:19 INFO - 'LOGNAME': 'cltbld', 22:23:19 INFO - 'MAIL': '/var/mail/cltbld', 22:23:19 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 22:23:19 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 22:23:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 22:23:19 INFO - 'MOZ_NO_REMOTE': '1', 22:23:19 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 22:23:19 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 22:23:19 INFO - 'NO_EM_RESTART': '1', 22:23:19 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 22:23:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 22:23:19 INFO - 'PWD': '/builds/slave/test', 22:23:19 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 22:23:19 INFO - 'SHELL': '/bin/bash', 22:23:19 INFO - 'SHLVL': '1', 22:23:19 INFO - 'TERM': 'linux', 22:23:19 INFO - 'TMOUT': '86400', 22:23:19 INFO - 'USER': 'cltbld', 22:23:19 INFO - 'XDG_SESSION_COOKIE': '0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360', 22:23:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 22:23:19 INFO - '_': '/tools/buildbot/bin/python'} 22:23:19 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'B2G-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-049', '--webServer', 'localhost'] with output_timeout 3600 22:23:19 INFO - mozversion INFO | application_buildid: 20151122215326 22:23:19 INFO - mozversion INFO | application_changeset: f92df94073a3c3aca1b7b372c3a1fff843bbf127 22:23:19 INFO - mozversion INFO | application_display_name: Nightly 22:23:19 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 22:23:19 INFO - mozversion INFO | application_name: Firefox 22:23:19 INFO - mozversion INFO | application_remotingname: firefox 22:23:19 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/b2g-inbound 22:23:19 INFO - mozversion INFO | application_vendor: Mozilla 22:23:19 INFO - mozversion INFO | application_version: 45.0a1 22:23:19 INFO - mozversion INFO | platform_buildid: 20151122215326 22:23:19 INFO - mozversion INFO | platform_changeset: f92df94073a3c3aca1b7b372c3a1fff843bbf127 22:23:19 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/b2g-inbound 22:23:19 INFO - mozversion INFO | platform_version: 45.0a1 22:23:19 INFO - 2015-11-22 22:23:19,762 DEBUG : using testdate: 1448259799 22:23:19 INFO - 2015-11-22 22:23:19,762 DEBUG : actual date: 1448259799 22:23:19 INFO - 2015-11-22 22:23:19,770 INFO : starting webserver on 'localhost:49345' 22:23:19 INFO - 2015-11-22 22:23:19,771 INFO : Starting test suite talos-linux64-ix-049 22:23:19 INFO - 2015-11-22 22:23:19,771 INFO : Starting test dromaeo_css 22:23:19 INFO - 2015-11-22 22:23:19,771 DEBUG : operating with platform_type : linux_ 22:23:19 INFO - 2015-11-22 22:23:19,772 INFO : Initialising browser for dromaeo_css test... 22:23:19 INFO - 2015-11-22 22:23:19,782 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqLADA/profile http://localhost:49345/getInfo.html 22:23:24 INFO - 2015-11-22 22:23:24,519 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:23:24 INFO - 2015-11-22 22:23:24,519 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:23:24 INFO - 2015-11-22 22:23:24,519 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:23:24 INFO - 2015-11-22 22:23:24,519 DEBUG : BROWSER_OUTPUT: __metrics 22:23:24 INFO - 2015-11-22 22:23:24,661 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:23:26 INFO - 2015-11-22 22:23:26,001 INFO : Browser initialized. 22:23:26 INFO - 2015-11-22 22:23:26,002 INFO : Running cycle 1/1 for dromaeo_css test... 22:23:26 INFO - 2015-11-22 22:23:26,002 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpsqLADA/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:23:37 INFO - 2015-11-22 22:23:37,971 DEBUG : BROWSER_OUTPUT: RSS: Main: 142057472 22:23:37 INFO - 2015-11-22 22:23:37,971 DEBUG : BROWSER_OUTPUT: 22:24:29 INFO - 2015-11-22 22:24:29,444 DEBUG : BROWSER_OUTPUT: 1448259869444 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 22:26:41 INFO - 2015-11-22 22:26:41,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49345/tests/dromaeo/cssquery-ext.html) 22:26:42 INFO - 2015-11-22 22:26:42,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 237264896 22:26:42 INFO - 2015-11-22 22:26:42,937 DEBUG : BROWSER_OUTPUT: 22:29:45 INFO - 2015-11-22 22:29:45,429 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-ext.html (next: http://localhost:49345/tests/dromaeo/cssquery-jquery.html) 22:29:45 INFO - 2015-11-22 22:29:45,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 218513408 22:29:45 INFO - 2015-11-22 22:29:45,996 DEBUG : BROWSER_OUTPUT: 22:32:48 INFO - 2015-11-22 22:32:48,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49345/tests/dromaeo/cssquery-mootools.html) 22:32:48 INFO - 2015-11-22 22:32:48,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 222666752 22:32:48 INFO - 2015-11-22 22:32:48,598 DEBUG : BROWSER_OUTPUT: 22:35:50 INFO - 2015-11-22 22:35:50,532 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49345/tests/dromaeo/cssquery-prototype.html) 22:35:51 INFO - 2015-11-22 22:35:51,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 204386304 22:35:51 INFO - 2015-11-22 22:35:51,118 DEBUG : BROWSER_OUTPUT: 22:38:53 INFO - 2015-11-22 22:38:53,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49345/tests/dromaeo/cssquery-yui.html) 22:38:54 INFO - 2015-11-22 22:38:54,525 DEBUG : BROWSER_OUTPUT: RSS: Main: 204070912 22:38:54 INFO - 2015-11-22 22:38:54,525 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,215 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/dromaeo/cssquery-yui.html (next: http://localhost:49345/tests/dromaeo/cssquery-dojo.html) 22:41:57 INFO - 2015-11-22 22:41:57,473 DEBUG : BROWSER_OUTPUT: RSS: Main: 272289792 22:41:57 INFO - 2015-11-22 22:41:57,473 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,473 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:41:57 INFO - 2015-11-22 22:41:57,473 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:41:57 INFO - 2015-11-22 22:41:57,474 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:41:57 INFO - 2015-11-22 22:41:57,474 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:41:57 INFO - 2015-11-22 22:41:57,474 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2646.841189528628;2704.1617098699403;2717.5787752898295;2718.0215122555865;2736.1381164933046;4521.525239849818;4677.74272415017;4688.249880019198;4702.294655801631;4729.125111854305;4641.744704041276;4648.581627653511;4661.044485880395;4714.646401519891;4721.173794585951;4328.177646247219;4390.319500477431;4417.867463976086;4425.137098265839;4445.355423463596;4252.128313695701;4457.353683715859;4459.37568740375;4513.50351461339;4522.344260082286;4228;4285.421468101828;4329.545397733255;4342.913141737164;4348.543402942677;4327.32926396409;4332.9566704332865;4343.370211319372;4365.061511774952;4371.453568303962;4163;4292.7209731367675;4309.00892794659;4328.696991210617;4347.043650396908;4512.954870451286;4545.227311357077;4574.519675434098;4666.766661666903;4706.129366067288;5092.108880945857;5116.667416617908;5120.308758317617;5126.333576635051;5165.715885626327;4890.095332363524;5106.591472682177;5141.562967147797;5146.202338637517;5150.742462876841;4596.988662494246;4674.111918735463;4679.344891715163;4695.22528782747;4746.620270378361;5192.299039629602;5238.188080847474;5239.266502689627;5241.161414173714;5247.527722504917;4746.406699162605;5016.598672106223;5039.21892106724;5044.571211447068;5084.161113416319;4970.826021089245;4987.177115775857;4988.575971042502;5028.59771218309;5040.143175660073;4987.102321582078;5010.498950105033;5014.197728363444;5016;5060.468650791688;4755.83354582588;4981.9252711209365;4987.351644286292;4987.551120399182;5038.496150384932;4136.834526618962;4174.3947127666315;4174.666026717855;4212.68404869636;4215.78921053946;3690.8523659053876;3702.129999450127;3703.148275896559;3731.365667836474;3731.4029755239576;4337.696361254745;4378.605925466723;4383.16719823239;4398.142362239397;4411.757353345597;4881.658283920092;4967.826126085642;4988.7505624718615;4999.075171093359;5001.924971125436;4349.238883195429;4356.28121359972;4374.993751437188;4395.428594282723;4429.11417716458;4519.389882365905;4524.2082635538645;4528.932066019012;4533.410656614685;4574.679772415899;4609.907801844011;4734.4081989751285;4735.573798358164;4843.588294994895;4860.854174374775;4918.680285781413;4985.152524070989;4989.750512474435;4991.401031876198;5026.52248036436;4865.245886887538;4869.537393947569;4877.853664390074;4883.633727470383;4933.136701077226;4720.221163507983;4811.422629284508;4818.855434336975;5076.18780995039;5125.74371281427;4974.701517908792;4979.402471703419;5064.063148317573;5180.352455943007;5216.686998780086;4935.16102262609;4965;4965.255211718271;4969.130402179532;5021.748912554284;4915.680480768881;4949.084419382426;4958.504149585013;4966.428860681068;5020.548150666312;4571.38286331341;4671;4676.649251306234;4731.645126615449;4843.370361853077;4958.181899986462;4985.775640096132;4991.900161996812;4998.400191976986;5040.697558146377;4871.391076115486;4890.364252647133;4896.045271172087;4899.3385892904;4939.753012349296 22:41:57 INFO - 2015-11-22 22:41:57,475 DEBUG : BROWSER_OUTPUT: |1;ext.html;572.3703925681754;576.685706290072;581.1544203184367;584.859633687915;585.2917969257198;28730.13809585713;29168.85415572922;35013.649863501356;35330;35332;41001.794991025075;41472;41505.58494415055;41515.377269340985;41596;7070.399016083614;7844.646990885424;8075.071366792835;8085.636146373398;8088.352931765474;7161.176464706547;7274.4180465562895;7276.272372762708;7276.890846637305;9993.900060999405;10223.693289201336;10301.742456438611;10304.433256170907;10311;10324.070833624972;10176.185905127571;10277.794444111114;10287.074163325336;10301.639442619473;10312.1234695051;7163.212046674862;7320.707171713125;10244.334118282362;10513.84229236562;10520.053195212467;38969.22061558753;39361.40957885634;39404;39474.407883881766;39508.20983580312;2819.154253723895;2851.3441908360987;2965.988016812223;3040.2095455181593;3586.8385922633543;29337.41325173506;29641.851790741122;29667.70332296671;29701.851490742625;29790.404191916256;3522.947155792665;3586.659267369596;3589.4974703541525;3632.3098611263777;3718.0518967663343;224403;227194;227389;229817;229859;52528.212076818876;58712.41287587155;59174.40825591775;59193;59262;49614.75192624014;62617.68691156515;63449.36550634527;63458;63490.68254658697;13453.125546839425;13786.448542058206;13807.654808629664;13809.585712428643;13815.792763108562;10222.693319200436;10354.068133867837;10356.896431035744;10361.74095647615;10363.740906477398;19257.332496187933;19695.212191512466;19817.801821981884;19878;19908.90045549792;7602.619869006528;7830.960845195737;7893.368530517545;7930.881036784453;7971.561564113914;871.6164887449502;882.5322579032994;960.0879164793474;978.8972157923458;1025.9538320775582;26424.603630945552;26851.462970740475;27016.459670806475;27070;27084.59373109405;934.7336009237334;939.4973689076448;1078.7033565769477;1081.5781845080426;1094.3105843318658;13515.324233788271;13671.726565468634;13748.106373085717;13770.518031868836;13790.517331893336;341787;345773;346237;347451;347913;41667;42469.362959555634;49696;50274;54395;1210.195220178589;1211.8485189351331;1212.8362671039297;1227.7114878003663;1233.7409144079663;26557.14921336357;27532.862335688194;28013.719862801925;28128.156155315373;28306.433871322046;40934.59065409308;41550.58449415588;41565.37651935163;41632.583674162874;41634.375484368364;258381;263564;266302.0328170474;267556;267842;30266.84866575653;30267.545986809775;30632.540511892785;30641.693583064774;30647.080587582408;39005;39238;40310.79844600758;40334.596654033085;40418.1916361677;34367.82816085903;34385.312293753486;34733.30533389369;34792.47811282782;38220.80889595534;34522.13694657654;34749.05399813546;35111.297774044884;35273.47089793706;35332;35291.823540882135;35579.110522236115;37858.81070594629;38687.41968870525;39180.608193917695;29516.262093446978;30791.692083078884;31001.8449907749;31238.375232495677;31573.684263157073;23892.64161037551;23980.160694375612;24322.51354972926;24518.38704032342;25438.618420723335 22:41:57 INFO - 2015-11-22 22:41:57,476 DEBUG : BROWSER_OUTPUT: |2;jquery.html;340.63041599864147;341.5116383571492;343.73704116350996;344.1671155802957;349.95275637788893;12319.384030798446;12598;14725.705485890288;14964.625884352883;16622.83377166228;13487.460501579924;13885.375158117884;15025.398984040625;15809.60475988101;15825.366985320603;4934.876628084291;4989.226669866168;5073.112205364065;5073.315102461157;5141.948580514184;3339.599248090233;3450.9827450862713;5125.051865404912;5209.869753256161;5359.1425371940495;5284.8150314739;5316.601254905898;5325.547328477065;5341.946580534183;5357.196420536911;5341.359036915575;5417.51242388185;5666.744996475169;5682.857928551819;5689.943100568983;5037.546620804109;5047.192449208109;5049.242613607951;5050.671706339076;5058.519440653132;11869.88130118705;11876.346800925945;11885.5840045598;11929.28424294545;14494.202818844959;1775.7336399540043;1812.0758413209226;1855.3042609021618;1883.9340623078126;1906.733057371969;8851.60167792451;8863.157999989991;8926.419782714103;9066.184043436057;9122.635094596208;1752.535578071812;1752.9123543822886;1764.4882983934644;1792.3010026089835;1815.9182836772377;53435.46564534383;55911;55918;56440.43559564352;56447;9694;9847.409155450696;9874.308798384187;9897.257705672104;9919.2560557957;12466.75066498683;12467.93766031164;12512.68718282032;12516.436760345807;12518.06114541413;7060.117485314336;7096.432285417154;7113.110861142357;7129.073220481304;7135.250798666169;6690.397864192246;6722.361375669401;6730.226024007302;6744.5278830482375;6747.122874026345;4103.117829666636;4173.8956526087095;4182.142660754538;4216.3464662977285;4223.72545784523;1519.5061604978425;1588.801399825022;1626.8047834259964;1667.84989350959;1691.4249155287262;843.8227972125923;863.2575984653193;887.1970866365949;941.9105185007413;996.9052939970691;12782.680432989064;14736.778948315783;14835.629109272355;14888.776668349983;15781.842181578268;779.742684913977;779.9977029517044;783.0094929913664;803.1566854802551;851.6040041380787;8225.79435514105;8385.413021088465;8529.275011623957;8618.870716939251;8681.609327580274;338181;339004;339609;344495;345881;37518.812405937795;49584.75207623939;60680.393196068355;61586;62599;1054.9261551691309;1058.7406085508946;1099.9395033273088;1138.408027825526;1139.641013080877;14128.434862605793;14179.574612761633;14187.574372768833;14206.21865797391;14944.402223910922;29318.853405732836;29547.55678664865;31916.6808331923;33185.33629327352;33251.667483324854;40661.79669101635;41773;42123.7893810529;42676.573234267256;45313.09373812571;8410.789730256793;8764.868526972228;8770.429922055046;8775.868361974448;8789.516576588348;10395.688129356131;10444.06003459662;11631.360275184947;13241.3379331035;16456.094914779802;12556.748865022832;12970.870291296966;13127.212367257995;13337.866621333662;13469;2326.674265602783;2344.355302291883;6086.6348019119;12876.678083047998;12979.106268119715;12250.693732656755;12551.497940082294;12561.937190314355;12634.178778379375;12903.741925161257;8384.413091083565;8658.56707164652;8702.608382622924;8818.074102219174;8828.690995815115;9439.858402123837;9562.330636855353;11078.390688512209;13329.266890321125;13950.23273719955 22:41:57 INFO - 2015-11-22 22:41:57,477 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1187.6496433552102;1379.9793003104955;1443.1629654800213;1520.7186670465965;1676.7820183376166;5784.76860925563;6245.906311405332;6393.808185754435;6396.584222025571;6397.0404439334125;6530.70611822468;6538.150040494741;6557.278699343068;6598.769043083493;6603.801885943418;1744.1105036431447;1778.5820332221917;2061.5876824635056;2077.854550181488;2083.2292051940804;2081.8646787958733;2111.3876975677035;2111.9049642766113;2112.1234687604624;2116.9894150529226;2046.2428901306537;2047.1504325704814;2053.887036213008;2095.4551816527737;2098.8320934325293;1987.1653905359783;2079.064421010544;2097.821685156748;2107.6206282869002;2111.144986280551;2097.140172529271;2115.968260476094;2119.73503312086;2119.8516103872735;2120.236714782677;6783.694733736994;6794.252632210502;6840.794776156723;6844.965775171092;6847.554908930903;4025.5974402559805;4080.10237747695;4089.9591004090175;4110.157417729388;4117.21772863158;2709.4310194859104;2818.2954261434643;2824.8587570621385;2849.7292757188243;2853.0299698102535;758.3175142371854;897.0715309654477;912.8721978922956;925.791696868206;938.549496241801;8872.689455869013;9008.729738107868;9023.142801433918;9032.187103160748;9048.502332371718;3963.445117683469;3970.622790834866;4035.435039094529;4036.37436197384;4046.919061618751;7824.21757824213;7825.060992680801;7828.334591559781;7830.373570114377;7848.372130229568;4127.525334586501;4144.295469770086;4147.3778933160265;4153.626173644387;4157.230912281238;3799.3351163546267;3801.2207497462955;3802.9429558556644;3806.9428958565645;3811.961880381161;3350.2294472271515;3353.9161520961684;3363.9495407568907;3373.4433818420175;3378.3750006248924;1065.0680654427376;1065.717584840018;1070.983935240972;1074.2426589254712;1086.4839201379439;898;980.2648013989508;1156.1271240213584;1171.472837223253;1172.8299396587447;6422.74309027643;6444.8388790280615;6489.253735820441;6491.7078731457195;6497.772577959749;1029.505837198149;1032.566322144701;1034.906858382749;1045.3936716704293;1070.8755806403246;5129.563987061141;5140.845774626767;5144.331236939249;5154.046501397253;5158.535731784157;7108.573485590778;7361.263873612703;7707.653155608011;7721.92278077212;7865.567393793396;7485.25147485258;7531.397488201041;7550.471466997367;7575.053118360205;7607.505512141693;6319.6208227506495;6370.777022804273;6394.23269207698;6394.360563943662;6394.968025159845;6211.689415529296;6330.272018717907;6345.873082538231;6410.583312084699;6424.421802037839;7134.108236470442;7175.497715159889;7263.201047884623;7268.67290971897;7292.978982942286;7324.340809327186;7439.92560074414;7443.069616297963;7446.515976461513;7465.141508726566;5707.286589176353;5785.942140578709;5786.797462088806;5795.913061304168;5798.6810725410505;5961.2846458425265;6532.281449040506;6551.279359270381;6564.868702625825;6608.636524991171;6203.045076726393;6211.409916057967;6232.220972378453;6253.187085678833;6299.559030867796;5928.733207005781;5990.550708696778;5991.730372133352;6001.039833626599;6169.722362493609;6201.10084037821;6220.315765265726;6234.220722409699;6236.6258024518675;6241.937580624136;5575.944240557705;5701.40135285789;5723.8569035774435;5737.225474560881;5738.282714660668;5625.296837895263;5717.456841600041;5720.885582288248;5755.5683323750045;5790.131480277992 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.8970739655914;316.54259594885383;321.7184963157238;322.9192701824542;324.336731384319;5230.424653288135;5234.42421333653;5371.462853714636;5373.81191658292;5464.480874316943;5146.665466744659;5293.682379057259;5319.6808191508535;5321.467853214686;5326.041312563737;3938.4092386142165;4032.3951407288846;4166.833326666937;4167.562405947362;4172.207280616673;4068.3694027425795;4160.45914031177;4169.749815011094;4170.603792639695;4172.5410204877435;4118.608732170439;4130.359794231899;4131.834726610932;4132;4140.544540100586;4128.62842344189;4130.772807495571;4135.60711732385;4136.565660605623;4141.834326626931;3625.6374362563797;3628.2017956049626;3628.8367023483743;3634.000649821294;3637.8181090945345;4939.407271127488;5065.265536497224;5110.872228194287;5118.0019896120275;5129.05112554175;4744.14605371033;4744.4069491313585;4748.264019077049;4749.358836557055;4753.33453316536;5352.759125839347;5530.806421775219;5649.4633009864;5651.2935883014625;5652.971735141339;3824.2542704172697;3928.4696565963513;3929.842806287745;3953.6244056814558;3960.049588098864;5854.736536855852;5930.406959304079;5932.9406705932815;5939.1388248704125;5941.524678025704;4053.452783874139;4054.4729185205733;4054.8175332110127;4054.9659836741444;4058.5332686740812;4035.757854528738;4112.897177570525;4120.587941205916;4120.835166593362;4126.546079931205;4718.245080787057;4719.843638308636;4722.858314250578;4724.031573527419;4725.054989002145;5626.437356264422;5628.0713682242795;5629.127485239795;5630.5495560355075;5635.408282130317;1433.4911106557022;1446.7251222267735;1447.5874375802846;1448.4278709909527;1449.3188201545256;971.5967873332629;972.3436680240809;976.3214565876648;998.8701468809008;999.020959459719;4965.751712414365;4985.725785081783;4990.351254336985;5000.774965126578;5001.8499445016705;5840.591158618856;5863.501602363762;5864.970675146682;5868.853278668067;5876.529877609781;4964.528369804862;4972.900541989212;4976.402831660224;4978;4981.427135879348;3081.6764239754953;3143.292759129223;3162.0355791483357;3165.382750363657;3172.587563616761;5523.28197334344;5534.363548191929;5536.031194541019;5550.72246387679;5557.360903496069;6002.669853158118;6003.909941350883;6018.277806663141;6018.518518518508;6029.698515074228;5528.585356098309;5536.2249285100115;5539.501444869981;5547.750351234285;5551.000819852466;5632.352279487911;5691.8292451226525;5909.527237820878;5919.052951527735;5938.168656388196;5596.132599447093;5614;5735.082386818089;5772.855678607901;5776.913346299725;5536.4186760389575;5584.246126772996;5593.328800543798;5596;5600.85997850057;4152.4601801765575;4194.475690538683;4201.18076974987;4203.390508376329;4205.537390886939;5728.598998070095;5842.941570584239;5842.948269311395;5927.940720592739;5930;5692.573057020657;5696.287964004499;5698.743556539883;5699.629524080921;5699.772009119589;5683.2895888014;5687.260656114679;5687.260656114844;5688.431156884279;5697.088465845445;5387.81142660005;5526.253955716088;5569.749361278671;5571.1086226203615;5579.693116878449;5715.028445164249;5716.9709452298985;5724.542036637143;5725.427457254241;5729.770809167587;5558.749856256397;5558.944410556004;5562.610617256753;5566.4990150886615;5572.832815015556 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: |5;yui.html;652.6019128331718;760.1979911193696;760.8972788673527;766.7009866152201;792.8335049639571;11095.500702468387;11366.60216892409;11386.259893106942;11386.886131138686;11415.31508109514;11428.08575313975;11433.771324573525;11435.142364322668;11437.027852632536;11823.467943942522;616.1066453642214;622.1756173070677;781.2968328504335;787.6455594982252;795.399473397584;794.9284564389204;797.2625321577547;797.4975765267902;798.5967086621248;803.7749430159536;832.883396324515;833.9166083391673;839.0518713853337;840.7351684219482;840.7645859159414;645.0710976194289;654.7937399719074;818.3657665309373;831.5468069901918;832.7585000349891;610.8625559249133;611.2359550561798;611.9841063834059;612.3111499562991;613.2824595223599;11244;11393.202475826696;11421.086313094933;11432.599859004895;11443.942780286045;10832.40421776802;11810.350430726307;11895.82156267648;12077.637670869888;12102.636920892388;9375.249980001583;9376.484293363863;9415.670451534232;9423.199028082621;9451.52742362886;3277.5575297334794;3303.587051618548;3332.350191712617;3340.3820293245585;3414.26593282443;40873.79563102195;40889.591104088875;40951.1809763806;41005.384919226235;42286;9454.149126578503;9533.713988580354;9579.281553883488;9581.616735330508;9598.760030999141;16296.185190740416;16304.940178888572;16335.836641633668;16346.528812406941;16362.38201887716;6202.131701561785;6214.098955651405;6254.124422580842;6264.812055638247;6374.74501019954;3641.4537819326783;3645.708343332527;3665.52348194733;3668.5230919980763;3682.429223470313;2721.7958653101095;2765.5713364428548;2767.4741799058115;2768.1280396674983;2768.6123942648046;498.68831980012493;501.66137856946415;513.5916946027917;515.9638825282194;517.3688100517363;516.2591680937866;552.5524325296523;584.8917950179231;613;656.0978654350268;8136.003037387842;8747.650093996295;8825.38222324444;8928.732138035739;9000.60413386029;569.6354333226739;582.7325566891993;624.5565648389694;624.5877720704405;633.1547384242089;3683.4474828775897;3804.7907365095184;3841.8271177797064;3866.6906647468136;3881.6700580450415;48544.514554854;48574.75712621414;50590.24114638283;50627.24059139116;50865.745671271405;39646.80176599098;39744;39791.40312895309;40048.19903601912;40116.79941600332;36115.638843611756;36831.81584092062;37333.43999840005;37356.62643373586;37396.62603373932;7833.686652534063;8051.557164356017;8118.431709780259;8287.40864981419;8423.410361274651;30600.387992240478;31116;31503.212419688774;31522.527162092127;32579;39934.201315974096;40143.3978490317;40581.39127913024;40790.79604602077;40909.59090409177;10317.845232321371;10394.428306442916;10409.895901040893;10435.478226088513;10500.684979450629;11470.369129697612;11647.242929209575;11673.824892626788;11850.05199584014;12000.1599888007;10619.522121504397;10621.787564248827;10782.903676959106;11102.056325212125;11468;11050.778984420427;11128.109751220045;11135;11173;11578.421078946187;10111;10572.365658060233;10822.350658960488;10849.457527123453;11011.61459348919;9058.728238152866;9500.239980801658;9511.762205944906;9536.141747242782;9611;8959.507227102571;9076.591553379982;9129.817403651758;9454.101860323259;9507.239420846454 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,923 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: __startTimestamp1448260917472__endTimestamp 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: Number of tests: 6 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,479 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4661.13 Median:4746.41 stddev:486.18 (10.2%) stddev-sans-first:461.27 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: Values: 2646.8 2704.2 2717.6 2718.0 2736.1 4521.5 4677.7 4688.2 4702.3 4729.1 4641.7 4648.6 4661.0 4714.6 4721.2 4328.2 4390.3 4417.9 4425.1 4445.4 4252.1 4457.4 4459.4 4513.5 4522.3 4228.0 4285.4 4329.5 4342.9 4348.5 4327.3 4333.0 4343.4 4365.1 4371.5 4163.0 4292.7 4309.0 4328.7 4347.0 4513.0 4545.2 4574.5 4666.8 4706.1 5092.1 5116.7 5120.3 5126.3 5165.7 4890.1 5106.6 5141.6 5146.2 5150.7 4597.0 4674.1 4679.3 4695.2 4746.6 5192.3 5238.2 5239.3 5241.2 5247.5 4746.4 5016.6 5039.2 5044.6 5084.2 4970.8 4987.2 4988.6 5028.6 5040.1 4987.1 5010.5 5014.2 5016.0 5060.5 4755.8 4981.9 4987.4 4987.6 5038.5 4136.8 4174.4 4174.7 4212.7 4215.8 3690.9 3702.1 3703.1 3731.4 3731.4 4337.7 4378.6 4383.2 4398.1 4411.8 4881.7 4967.8 4988.8 4999.1 5001.9 4349.2 4356.3 4375.0 4395.4 4429.1 4519.4 4524.2 4528.9 4533.4 4574.7 4609.9 4734.4 4735.6 4843.6 4860.9 4918.7 4985.2 4989.8 4991.4 5026.5 4865.2 4869.5 4877.9 4883.6 4933.1 4720.2 4811.4 4818.9 5076.2 5125.7 4974.7 4979.4 5064.1 5180.4 5216.7 4935.2 4965.0 4965.3 4969.1 5021.7 4915.7 4949.1 4958.5 4966.4 5020.5 4571.4 4671.0 4676.6 4731.6 4843.4 4958.2 4985.8 4991.9 4998.4 5040.7 4871.4 4890.4 4896.0 4899.3 4939.8 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:44382.88 Median:34453.72 stddev:74319.06 (215.7%) stddev-sans-first:74454.75 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: Values: 572.4 576.7 581.2 584.9 585.3 28730.1 29168.9 35013.6 35330.0 35332.0 41001.8 41472.0 41505.6 41515.4 41596.0 7070.4 7844.6 8075.1 8085.6 8088.4 7161.2 7274.4 7276.3 7276.9 9993.9 10223.7 10301.7 10304.4 10311.0 10324.1 10176.2 10277.8 10287.1 10301.6 10312.1 7163.2 7320.7 10244.3 10513.8 10520.1 38969.2 39361.4 39404.0 39474.4 39508.2 2819.2 2851.3 2966.0 3040.2 3586.8 29337.4 29641.9 29667.7 29701.9 29790.4 3522.9 3586.7 3589.5 3632.3 3718.1 224403.0 227194.0 227389.0 229817.0 229859.0 52528.2 58712.4 59174.4 59193.0 59262.0 49614.8 62617.7 63449.4 63458.0 63490.7 13453.1 13786.4 13807.7 13809.6 13815.8 10222.7 10354.1 10356.9 10361.7 10363.7 19257.3 19695.2 19817.8 19878.0 19908.9 7602.6 7831.0 7893.4 7930.9 7971.6 871.6 882.5 960.1 978.9 1026.0 26424.6 26851.5 27016.5 27070.0 27084.6 934.7 939.5 1078.7 1081.6 1094.3 13515.3 13671.7 13748.1 13770.5 13790.5 341787.0 345773.0 346237.0 347451.0 347913.0 41667.0 42469.4 49696.0 50274.0 54395.0 1210.2 1211.8 1212.8 1227.7 1233.7 26557.1 27532.9 28013.7 28128.2 28306.4 40934.6 41550.6 41565.4 41632.6 41634.4 258381.0 263564.0 266302.0 267556.0 267842.0 30266.8 30267.5 30632.5 30641.7 30647.1 39005.0 39238.0 40310.8 40334.6 40418.2 34367.8 34385.3 34733.3 34792.5 38220.8 34522.1 34749.1 35111.3 35273.5 35332.0 35291.8 35579.1 37858.8 38687.4 39180.6 29516.3 30791.7 31001.8 31238.4 31573.7 23892.6 23980.2 24322.5 24518.4 25438.6 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,481 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:21160.15 Median:22382.46 stddev:55915.88 (249.8%) stddev-sans-first:56050.89 22:41:57 INFO - 2015-11-22 22:41:57,482 DEBUG : BROWSER_OUTPUT: Values: 340.6 341.5 343.7 344.2 350.0 12319.4 12598.0 14725.7 14964.6 16622.8 13487.5 13885.4 15025.4 15809.6 15825.4 4934.9 4989.2 5073.1 5073.3 5141.9 3339.6 3451.0 5125.1 5209.9 5359.1 5284.8 5316.6 5325.5 5341.9 5357.2 5341.4 5417.5 5666.7 5682.9 5689.9 5037.5 5047.2 5049.2 5050.7 5058.5 11869.9 11876.3 11885.6 11929.3 14494.2 1775.7 1812.1 1855.3 1883.9 1906.7 8851.6 8863.2 8926.4 9066.2 9122.6 1752.5 1752.9 1764.5 1792.3 1815.9 53435.5 55911.0 55918.0 56440.4 56447.0 9694.0 9847.4 9874.3 9897.3 9919.3 12466.8 12467.9 12512.7 12516.4 12518.1 7060.1 7096.4 7113.1 7129.1 7135.3 6690.4 6722.4 6730.2 6744.5 6747.1 4103.1 4173.9 4182.1 4216.3 4223.7 1519.5 1588.8 1626.8 1667.8 1691.4 843.8 863.3 887.2 941.9 996.9 12782.7 14736.8 14835.6 14888.8 15781.8 779.7 780.0 783.0 803.2 851.6 8225.8 8385.4 8529.3 8618.9 8681.6 338181.0 339004.0 339609.0 344495.0 345881.0 37518.8 49584.8 60680.4 61586.0 62599.0 1054.9 1058.7 1099.9 1138.4 1139.6 14128.4 14179.6 14187.6 14206.2 14944.4 29318.9 29547.6 31916.7 33185.3 33251.7 40661.8 41773.0 42123.8 42676.6 45313.1 8410.8 8764.9 8770.4 8775.9 8789.5 10395.7 10444.1 11631.4 13241.3 16456.1 12556.7 12970.9 13127.2 13337.9 13469.0 2326.7 2344.4 6086.6 12876.7 12979.1 12250.7 12551.5 12561.9 12634.2 12903.7 8384.4 8658.6 8702.6 8818.1 8828.7 9439.9 9562.3 11078.4 13329.3 13950.2 22:41:57 INFO - 2015-11-22 22:41:57,483 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,483 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4742.27 Median:5788.46 stddev:2348.05 (40.6%) stddev-sans-first:2339.43 22:41:57 INFO - 2015-11-22 22:41:57,483 DEBUG : BROWSER_OUTPUT: Values: 1187.6 1380.0 1443.2 1520.7 1676.8 5784.8 6245.9 6393.8 6396.6 6397.0 6530.7 6538.2 6557.3 6598.8 6603.8 1744.1 1778.6 2061.6 2077.9 2083.2 2081.9 2111.4 2111.9 2112.1 2117.0 2046.2 2047.2 2053.9 2095.5 2098.8 1987.2 2079.1 2097.8 2107.6 2111.1 2097.1 2116.0 2119.7 2119.9 2120.2 6783.7 6794.3 6840.8 6845.0 6847.6 4025.6 4080.1 4090.0 4110.2 4117.2 2709.4 2818.3 2824.9 2849.7 2853.0 758.3 897.1 912.9 925.8 938.5 8872.7 9008.7 9023.1 9032.2 9048.5 3963.4 3970.6 4035.4 4036.4 4046.9 7824.2 7825.1 7828.3 7830.4 7848.4 4127.5 4144.3 4147.4 4153.6 4157.2 3799.3 3801.2 3802.9 3806.9 3812.0 3350.2 3353.9 3363.9 3373.4 3378.4 1065.1 1065.7 1071.0 1074.2 1086.5 898.0 980.3 1156.1 1171.5 1172.8 6422.7 6444.8 6489.3 6491.7 6497.8 1029.5 1032.6 1034.9 1045.4 1070.9 5129.6 5140.8 5144.3 5154.0 5158.5 7108.6 7361.3 7707.7 7721.9 7865.6 7485.3 7531.4 7550.5 7575.1 7607.5 6319.6 6370.8 6394.2 6394.4 6395.0 6211.7 6330.3 6345.9 6410.6 6424.4 7134.1 7175.5 7263.2 7268.7 7293.0 7324.3 7439.9 7443.1 7446.5 7465.1 5707.3 5785.9 5786.8 5795.9 5798.7 5961.3 6532.3 6551.3 6564.9 6608.6 6203.0 6211.4 6232.2 6253.2 6299.6 5928.7 5990.6 5991.7 6001.0 6169.7 6201.1 6220.3 6234.2 6236.6 6241.9 5575.9 5701.4 5723.9 5737.2 5738.3 5625.3 5717.5 5720.9 5755.6 5790.1 22:41:57 INFO - 2015-11-22 22:41:57,483 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,483 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4684.82 Median:5323.75 stddev:1374.46 (25.8%) stddev-sans-first:1338.55 22:41:57 INFO - 2015-11-22 22:41:57,485 DEBUG : BROWSER_OUTPUT: Values: 311.9 316.5 321.7 322.9 324.3 5230.4 5234.4 5371.5 5373.8 5464.5 5146.7 5293.7 5319.7 5321.5 5326.0 3938.4 4032.4 4166.8 4167.6 4172.2 4068.4 4160.5 4169.7 4170.6 4172.5 4118.6 4130.4 4131.8 4132.0 4140.5 4128.6 4130.8 4135.6 4136.6 4141.8 3625.6 3628.2 3628.8 3634.0 3637.8 4939.4 5065.3 5110.9 5118.0 5129.1 4744.1 4744.4 4748.3 4749.4 4753.3 5352.8 5530.8 5649.5 5651.3 5653.0 3824.3 3928.5 3929.8 3953.6 3960.0 5854.7 5930.4 5932.9 5939.1 5941.5 4053.5 4054.5 4054.8 4055.0 4058.5 4035.8 4112.9 4120.6 4120.8 4126.5 4718.2 4719.8 4722.9 4724.0 4725.1 5626.4 5628.1 5629.1 5630.5 5635.4 1433.5 1446.7 1447.6 1448.4 1449.3 971.6 972.3 976.3 998.9 999.0 4965.8 4985.7 4990.4 5000.8 5001.8 5840.6 5863.5 5865.0 5868.9 5876.5 4964.5 4972.9 4976.4 4978.0 4981.4 3081.7 3143.3 3162.0 3165.4 3172.6 5523.3 5534.4 5536.0 5550.7 5557.4 6002.7 6003.9 6018.3 6018.5 6029.7 5528.6 5536.2 5539.5 5547.8 5551.0 5632.4 5691.8 5909.5 5919.1 5938.2 5596.1 5614.0 5735.1 5772.9 5776.9 5536.4 5584.2 5593.3 5596.0 5600.9 4152.5 4194.5 4201.2 4203.4 4205.5 5728.6 5842.9 5842.9 5927.9 5930.0 5692.6 5696.3 5698.7 5699.6 5699.8 5683.3 5687.3 5687.3 5688.4 5697.1 5387.8 5526.3 5569.7 5571.1 5579.7 5715.0 5717.0 5724.5 5725.4 5729.8 5558.7 5558.9 5562.6 5566.5 5572.8 22:41:57 INFO - 2015-11-22 22:41:57,485 DEBUG : BROWSER_OUTPUT: 22:41:57 INFO - 2015-11-22 22:41:57,485 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12155.59 Median:40899.59 stddev:13411.24 (32.8%) stddev-sans-first:13421.04 22:41:57 INFO - 2015-11-22 22:41:57,485 DEBUG : BROWSER_OUTPUT: Values: 652.6 760.2 760.9 766.7 792.8 11095.5 11366.6 11386.3 11386.9 11415.3 11428.1 11433.8 11435.1 11437.0 11823.5 616.1 622.2 781.3 787.6 795.4 794.9 797.3 797.5 798.6 803.8 832.9 833.9 839.1 840.7 840.8 645.1 654.8 818.4 831.5 832.8 610.9 611.2 612.0 612.3 613.3 11244.0 11393.2 11421.1 11432.6 11443.9 10832.4 11810.4 11895.8 12077.6 12102.6 9375.2 9376.5 9415.7 9423.2 9451.5 3277.6 3303.6 3332.4 3340.4 3414.3 40873.8 40889.6 40951.2 41005.4 42286.0 9454.1 9533.7 9579.3 9581.6 9598.8 16296.2 16304.9 16335.8 16346.5 16362.4 6202.1 6214.1 6254.1 6264.8 6374.7 3641.5 3645.7 3665.5 3668.5 3682.4 2721.8 2765.6 2767.5 2768.1 2768.6 498.7 501.7 513.6 516.0 517.4 516.3 552.6 584.9 613.0 656.1 8136.0 8747.7 8825.4 8928.7 9000.6 569.6 582.7 624.6 624.6 633.2 3683.4 3804.8 3841.8 3866.7 3881.7 48544.5 48574.8 50590.2 50627.2 50865.7 39646.8 39744.0 39791.4 40048.2 40116.8 36115.6 36831.8 37333.4 37356.6 37396.6 7833.7 8051.6 8118.4 8287.4 8423.4 30600.4 31116.0 31503.2 31522.5 32579.0 39934.2 40143.4 40581.4 40790.8 40909.6 10317.8 10394.4 10409.9 10435.5 10500.7 11470.4 11647.2 11673.8 11850.1 12000.2 10619.5 10621.8 10782.9 11102.1 11468.0 11050.8 11128.1 11135.0 11173.0 11578.4 10111.0 10572.4 10822.4 10849.5 11011.6 9058.7 9500.2 9511.8 9536.1 9611.0 8959.5 9076.6 9129.8 9454.1 9507.2 22:41:57 INFO - 2015-11-22 22:41:57,486 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:41:57 INFO - 2015-11-22 22:41:57,486 DEBUG : BROWSER_OUTPUT: 22:41:58 INFO - 2015-11-22 22:41:58,158 INFO : Browser exited with error code: 0 22:41:58 INFO - 2015-11-22 22:41:58,179 INFO : Completed test dromaeo_css (00:18:38) 22:41:58 INFO - 2015-11-22 22:41:58,179 INFO : Starting test kraken 22:41:58 INFO - 2015-11-22 22:41:58,179 DEBUG : operating with platform_type : linux_ 22:41:58 INFO - 2015-11-22 22:41:58,179 INFO : Initialising browser for kraken test... 22:41:58 INFO - 2015-11-22 22:41:58,185 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yJAS1/profile http://localhost:49345/getInfo.html 22:42:02 INFO - 2015-11-22 22:42:02,064 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:42:02 INFO - 2015-11-22 22:42:02,065 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:42:02 INFO - 2015-11-22 22:42:02,065 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:42:02 INFO - 2015-11-22 22:42:02,065 DEBUG : BROWSER_OUTPUT: __metrics 22:42:02 INFO - 2015-11-22 22:42:02,174 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:42:03 INFO - 2015-11-22 22:42:03,354 INFO : Browser initialized. 22:42:03 INFO - 2015-11-22 22:42:03,354 INFO : Running cycle 1/1 for kraken test... 22:42:03 INFO - 2015-11-22 22:42:03,355 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp1yJAS1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:42:15 INFO - 2015-11-22 22:42:15,280 DEBUG : BROWSER_OUTPUT: RSS: Main: 142180352 22:42:15 INFO - 2015-11-22 22:42:15,281 DEBUG : BROWSER_OUTPUT: 22:42:17 INFO - 2015-11-22 22:42:17,837 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49345/tests/kraken/driver.html?testName=audio-beat-detection) 22:42:18 INFO - 2015-11-22 22:42:18,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 179576832 22:42:18 INFO - 2015-11-22 22:42:18,418 DEBUG : BROWSER_OUTPUT: 22:42:21 INFO - 2015-11-22 22:42:21,107 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49345/tests/kraken/driver.html?testName=audio-dft) 22:42:21 INFO - 2015-11-22 22:42:21,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 168894464 22:42:21 INFO - 2015-11-22 22:42:21,680 DEBUG : BROWSER_OUTPUT: 22:42:24 INFO - 2015-11-22 22:42:24,732 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49345/tests/kraken/driver.html?testName=audio-fft) 22:42:25 INFO - 2015-11-22 22:42:25,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 152879104 22:42:25 INFO - 2015-11-22 22:42:25,298 DEBUG : BROWSER_OUTPUT: 22:42:27 INFO - 2015-11-22 22:42:27,298 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49345/tests/kraken/driver.html?testName=audio-oscillator) 22:42:27 INFO - 2015-11-22 22:42:27,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 154374144 22:42:27 INFO - 2015-11-22 22:42:27,871 DEBUG : BROWSER_OUTPUT: 22:42:30 INFO - 2015-11-22 22:42:30,085 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49345/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:42:30 INFO - 2015-11-22 22:42:30,645 DEBUG : BROWSER_OUTPUT: RSS: Main: 156975104 22:42:30 INFO - 2015-11-22 22:42:30,646 DEBUG : BROWSER_OUTPUT: 22:42:33 INFO - 2015-11-22 22:42:33,604 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49345/tests/kraken/driver.html?testName=imaging-darkroom) 22:42:34 INFO - 2015-11-22 22:42:34,185 DEBUG : BROWSER_OUTPUT: RSS: Main: 157540352 22:42:34 INFO - 2015-11-22 22:42:34,186 DEBUG : BROWSER_OUTPUT: 22:42:37 INFO - 2015-11-22 22:42:37,634 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49345/tests/kraken/driver.html?testName=imaging-desaturate) 22:42:38 INFO - 2015-11-22 22:42:38,216 DEBUG : BROWSER_OUTPUT: RSS: Main: 157663232 22:42:38 INFO - 2015-11-22 22:42:38,216 DEBUG : BROWSER_OUTPUT: 22:42:41 INFO - 2015-11-22 22:42:41,058 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49345/tests/kraken/driver.html?testName=json-parse-financial) 22:42:41 INFO - 2015-11-22 22:42:41,640 DEBUG : BROWSER_OUTPUT: RSS: Main: 157454336 22:42:41 INFO - 2015-11-22 22:42:41,640 DEBUG : BROWSER_OUTPUT: 22:42:43 INFO - 2015-11-22 22:42:43,361 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49345/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:42:43 INFO - 2015-11-22 22:42:43,927 DEBUG : BROWSER_OUTPUT: RSS: Main: 165142528 22:42:43 INFO - 2015-11-22 22:42:43,927 DEBUG : BROWSER_OUTPUT: 22:42:45 INFO - 2015-11-22 22:42:45,800 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:42:46 INFO - 2015-11-22 22:42:46,388 DEBUG : BROWSER_OUTPUT: RSS: Main: 166150144 22:42:46 INFO - 2015-11-22 22:42:46,388 DEBUG : BROWSER_OUTPUT: 22:42:48 INFO - 2015-11-22 22:42:48,513 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:42:49 INFO - 2015-11-22 22:42:49,094 DEBUG : BROWSER_OUTPUT: RSS: Main: 174809088 22:42:49 INFO - 2015-11-22 22:42:49,095 DEBUG : BROWSER_OUTPUT: 22:42:51 INFO - 2015-11-22 22:42:51,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:42:52 INFO - 2015-11-22 22:42:52,203 DEBUG : BROWSER_OUTPUT: RSS: Main: 179703808 22:42:52 INFO - 2015-11-22 22:42:52,203 DEBUG : BROWSER_OUTPUT: 22:42:54 INFO - 2015-11-22 22:42:54,770 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:42:55 INFO - 2015-11-22 22:42:55,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 178823168 22:42:55 INFO - 2015-11-22 22:42:55,352 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,101 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49345/tests/kraken/driver.html?testName=ai-astar) 22:42:57 INFO - 2015-11-22 22:42:57,347 DEBUG : BROWSER_OUTPUT: RSS: Main: 238649344 22:42:57 INFO - 2015-11-22 22:42:57,347 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,351 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:42:57 INFO - 2015-11-22 22:42:57,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:42:57 INFO - 2015-11-22 22:42:57,351 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:42:57 INFO - 2015-11-22 22:42:57,351 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:42:57 INFO - 2015-11-22 22:42:57,351 DEBUG : BROWSER_OUTPUT: |0;ai-astar;111;112;107;110;112;111;101;112;116;111 22:42:57 INFO - 2015-11-22 22:42:57,352 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;152;130;157;164;129;152;160;131;167;129 22:42:57 INFO - 2015-11-22 22:42:57,352 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;162;163;161;161;162;164;163;165 22:42:57 INFO - 2015-11-22 22:42:57,352 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;81;92;72;72;72;94;88;72 22:42:57 INFO - 2015-11-22 22:42:57,352 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;91;91;131;91;91;92;124;92;92;136 22:42:57 INFO - 2015-11-22 22:42:57,353 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;110;110;109;110;109;109;110;109;109 22:42:57 INFO - 2015-11-22 22:42:57,353 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;147;147;149;147;148;147;148;147;146;146 22:42:57 INFO - 2015-11-22 22:42:57,353 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;96;96;96;95;96;96;95 22:42:57 INFO - 2015-11-22 22:42:57,353 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;71;69;70;70;70;69;69;78;67;67 22:42:57 INFO - 2015-11-22 22:42:57,353 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;69;69;69;68;69;69 22:42:57 INFO - 2015-11-22 22:42:57,354 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;84;83;82;92;83;83;84;84;82 22:42:57 INFO - 2015-11-22 22:42:57,354 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;118;123;119;125;122;129;127;119;122 22:42:57 INFO - 2015-11-22 22:42:57,354 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;144;143;145;147;136;145;144;147;139 22:42:57 INFO - 2015-11-22 22:42:57,354 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;70;71;72;68;68;68;69;67;68 22:42:57 INFO - 2015-11-22 22:42:57,355 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:42:57 INFO - 2015-11-22 22:42:57,355 DEBUG : BROWSER_OUTPUT: __start_cc_report 22:42:57 INFO - 2015-11-22 22:42:57,355 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,967 22:42:57 INFO - 2015-11-22 22:42:57,355 DEBUG : BROWSER_OUTPUT: __end_cc_report 22:42:57 INFO - 2015-11-22 22:42:57,355 DEBUG : BROWSER_OUTPUT: __startTimestamp1448260977348__endTimestamp 22:42:57 INFO - 2015-11-22 22:42:57,356 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,359 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:42:57 INFO - 2015-11-22 22:42:57,359 DEBUG : BROWSER_OUTPUT: Number of tests: 14 22:42:57 INFO - 2015-11-22 22:42:57,359 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,359 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.30 Median:111.50 stddev:3.95 (3.5%) stddev-sans-first:4.18 22:42:57 INFO - 2015-11-22 22:42:57,359 DEBUG : BROWSER_OUTPUT: Values: 111.0 112.0 107.0 110.0 112.0 111.0 101.0 112.0 116.0 111.0 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:147.10 Median:154.50 stddev:15.64 (10.1%) stddev-sans-first:16.49 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: Values: 152.0 130.0 157.0 164.0 129.0 152.0 160.0 131.0 167.0 129.0 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.60 Median:163.00 stddev:1.26 (0.8%) stddev-sans-first:1.33 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 162.0 163.0 161.0 161.0 162.0 164.0 163.0 165.0 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:78.90 Median:77.00 stddev:9.11 (11.8%) stddev-sans-first:9.41 22:42:57 INFO - 2015-11-22 22:42:57,360 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 81.0 92.0 72.0 72.0 72.0 94.0 88.0 72.0 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:103.10 Median:91.00 stddev:19.01 (20.9%) stddev-sans-first:19.65 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 131.0 91.0 91.0 92.0 124.0 92.0 92.0 136.0 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: Values: 109.0 110.0 110.0 109.0 110.0 109.0 109.0 110.0 109.0 109.0 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.20 Median:147.00 stddev:0.92 (0.6%) stddev-sans-first:0.97 22:42:57 INFO - 2015-11-22 22:42:57,361 DEBUG : BROWSER_OUTPUT: Values: 147.0 147.0 149.0 147.0 148.0 147.0 148.0 147.0 146.0 146.0 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.80 Median:96.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 96.0 96.0 96.0 95.0 96.0 96.0 95.0 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.00 Median:70.00 stddev:3.09 (4.4%) stddev-sans-first:3.26 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: Values: 71.0 69.0 70.0 70.0 70.0 69.0 69.0 78.0 67.0 67.0 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:0.42 (0.6%) stddev-sans-first:0.33 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 69.0 69.0 69.0 68.0 69.0 69.0 22:42:57 INFO - 2015-11-22 22:42:57,362 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:83.50 stddev:2.96 (3.5%) stddev-sans-first:3.06 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: Values: 82.0 84.0 83.0 82.0 92.0 83.0 83.0 84.0 84.0 82.0 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:122.40 Median:122.50 stddev:3.66 (3.0%) stddev-sans-first:3.77 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: Values: 120.0 118.0 123.0 119.0 125.0 122.0 129.0 127.0 119.0 122.0 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:143.80 Median:145.00 stddev:3.74 (2.6%) stddev-sans-first:3.64 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: Values: 148.0 144.0 143.0 145.0 147.0 136.0 145.0 144.0 147.0 139.0 22:42:57 INFO - 2015-11-22 22:42:57,363 DEBUG : BROWSER_OUTPUT: 22:42:57 INFO - 2015-11-22 22:42:57,364 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.80 Median:68.50 stddev:1.69 (2.5%) stddev-sans-first:1.66 22:42:57 INFO - 2015-11-22 22:42:57,364 DEBUG : BROWSER_OUTPUT: Values: 67.0 70.0 71.0 72.0 68.0 68.0 68.0 69.0 67.0 68.0 22:42:57 INFO - 2015-11-22 22:42:57,364 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:42:57 INFO - 2015-11-22 22:42:57,364 DEBUG : BROWSER_OUTPUT: 22:42:58 INFO - 2015-11-22 22:42:58,201 INFO : Browser exited with error code: 0 22:42:58 INFO - 2015-11-22 22:42:58,249 INFO : Completed test kraken (00:01:00) 22:42:58 INFO - 2015-11-22 22:42:58,250 INFO : Starting test v8_7 22:42:58 INFO - 2015-11-22 22:42:58,250 DEBUG : operating with platform_type : linux_ 22:42:58 INFO - 2015-11-22 22:42:58,250 INFO : Initialising browser for v8_7 test... 22:42:58 INFO - 2015-11-22 22:42:58,256 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTYb3Xt/profile http://localhost:49345/getInfo.html 22:43:02 INFO - 2015-11-22 22:43:02,116 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 22:43:02 INFO - 2015-11-22 22:43:02,117 DEBUG : BROWSER_OUTPUT: colorDepth:24 22:43:02 INFO - 2015-11-22 22:43:02,117 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 22:43:02 INFO - 2015-11-22 22:43:02,117 DEBUG : BROWSER_OUTPUT: __metrics 22:43:02 INFO - 2015-11-22 22:43:02,246 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 22:43:03 INFO - 2015-11-22 22:43:03,474 INFO : Browser initialized. 22:43:03 INFO - 2015-11-22 22:43:03,475 INFO : Running cycle 1/1 for v8_7 test... 22:43:03 INFO - 2015-11-22 22:43:03,475 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpTYb3Xt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 22:43:15 INFO - 2015-11-22 22:43:15,451 DEBUG : BROWSER_OUTPUT: RSS: Main: 142028800 22:43:15 INFO - 2015-11-22 22:43:15,452 DEBUG : BROWSER_OUTPUT: 22:43:36 INFO - 2015-11-22 22:43:36,845 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49345/tests/v8_7/run.html (next: http://localhost:49345/tests/v8_7/run.html) 22:43:37 INFO - 2015-11-22 22:43:37,096 DEBUG : BROWSER_OUTPUT: RSS: Main: 442384384 22:43:37 INFO - 2015-11-22 22:43:37,096 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: __start_tp_report 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: |0;Richards;163.5322976287817 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.94901661256444 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: |2;Encrypt;279.9552071668533 22:43:37 INFO - 2015-11-22 22:43:37,097 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5020 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1984.126984126984 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |5;Earley;794.2811755361398 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |6;Boyer;11964.285714285714 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |7;RegExp;26025.641025641027 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |8;Splay;619.6660482374768 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4822.115384615385 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: __end_tp_report 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: __startTimestamp1448261017096__endTimestamp 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 22:43:37 INFO - 2015-11-22 22:43:37,098 DEBUG : BROWSER_OUTPUT: Number of tests: 10 22:43:37 INFO - 2015-11-22 22:43:37,099 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.53 Median:163.53 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: Values: 163.5 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.95 Median:190.95 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: Values: 190.9 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:279.96 Median:279.96 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,100 DEBUG : BROWSER_OUTPUT: Values: 280.0 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5020.00 Median:5020.00 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: Values: 5020.0 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1984.13 Median:1984.13 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: Values: 1984.1 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:794.28 Median:794.28 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: Values: 794.3 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:11964.29 Median:11964.29 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: Values: 11964.3 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26025.64 Median:26025.64 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: Values: 26025.6 22:43:37 INFO - 2015-11-22 22:43:37,101 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.67 Median:619.67 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: Values: 619.7 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4822.12 Median:4822.12 stddev:0.00 (0.0%) 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: Values: 4822.1 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 22:43:37 INFO - 2015-11-22 22:43:37,102 DEBUG : BROWSER_OUTPUT: 22:43:37 INFO - 2015-11-22 22:43:37,993 INFO : Browser exited with error code: 0 22:43:38 INFO - 2015-11-22 22:43:38,005 INFO : Completed test v8_7 (00:00:39) 22:43:38 INFO - 2015-11-22 22:43:38,121 INFO : Completed test suite (00:20:18) 22:43:38 INFO - 2015-11-22 22:43:38,121 DEBUG : Working with test: dromaeo_css 22:43:38 INFO - 2015-11-22 22:43:38,121 DEBUG : Generating results file: dromaeo_css 22:43:38 INFO - 2015-11-22 22:43:38,122 DEBUG : Working with test: kraken 22:43:38 INFO - 2015-11-22 22:43:38,123 DEBUG : Generating results file: kraken 22:43:38 INFO - 2015-11-22 22:43:38,123 INFO : javascript benchmark 22:43:38 INFO - 2015-11-22 22:43:38,123 DEBUG : Working with test: v8_7 22:43:38 INFO - 2015-11-22 22:43:38,123 DEBUG : Generating results file: v8_7 22:43:38 INFO - 2015-11-22 22:43:38,123 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:43:38 INFO - 2015-11-22 22:43:38,173 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,203,35]] 22:43:38 INFO - 2015-11-22 22:43:38,174 DEBUG : process_Request line: dromaeo_css 6283.22 graph.html#tests=[[72,203,35]] 22:43:38 INFO - 2015-11-22 22:43:38,174 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:43:38 INFO - 2015-11-22 22:43:38,204 DEBUG : process_Request line: kraken 1512.10 graph.html#tests=[[232,203,35]] 22:43:38 INFO - 2015-11-22 22:43:38,204 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 22:43:38 INFO - 2015-11-22 22:43:38,234 DEBUG : process_Request line: v8_7 19884.51 graph.html#tests=[[230,203,35]] 22:43:38 INFO - 2015-11-22 22:43:38,236 INFO : javascript benchmark 22:43:38 INFO - 2015-11-22 22:43:38,239 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2646.841189528628, 2704.1617098699403, 2717.5787752898295, 2718.0215122555865, 2736.1381164933046, 4521.525239849818, 4677.74272415017, 4688.249880019198, 4702.294655801631, 4729.125111854305, 4641.744704041276, 4648.581627653511, 4661.044485880395, 4714.646401519891, 4721.173794585951, 4328.177646247219, 4390.319500477431, 4417.867463976086, 4425.137098265839, 4445.355423463596, 4252.128313695701, 4457.353683715859, 4459.37568740375, 4513.50351461339, 4522.344260082286, 4228.0, 4285.421468101828, 4329.545397733255, 4342.913141737164, 4348.543402942677, 4327.32926396409, 4332.9566704332865, 4343.370211319372, 4365.061511774952, 4371.453568303962, 4163.0, 4292.7209731367675, 4309.00892794659, 4328.696991210617, 4347.043650396908, 4512.954870451286, 4545.227311357077, 4574.519675434098, 4666.766661666903, 4706.129366067288, 5092.108880945857, 5116.667416617908, 5120.308758317617, 5126.333576635051, 5165.715885626327, 4890.095332363524, 5106.591472682177, 5141.562967147797, 5146.202338637517, 5150.742462876841, 4596.988662494246, 4674.111918735463, 4679.344891715163, 4695.22528782747, 4746.620270378361, 5192.299039629602, 5238.188080847474, 5239.266502689627, 5241.161414173714, 5247.527722504917, 4746.406699162605, 5016.598672106223, 5039.21892106724, 5044.571211447068, 5084.161113416319, 4970.826021089245, 4987.177115775857, 4988.575971042502, 5028.59771218309, 5040.143175660073, 4987.102321582078, 5010.498950105033, 5014.197728363444, 5016.0, 5060.468650791688, 4755.83354582588, 4981.9252711209365, 4987.351644286292, 4987.551120399182, 5038.496150384932, 4136.834526618962, 4174.3947127666315, 4174.666026717855, 4212.68404869636, 4215.78921053946, 3690.8523659053876, 3702.129999450127, 3703.148275896559, 3731.365667836474, 3731.4029755239576, 4337.696361254745, 4378.605925466723, 4383.16719823239, 4398.142362239397, 4411.757353345597, 4881.658283920092, 4967.826126085642, 4988.7505624718615, 4999.075171093359, 5001.924971125436, 4349.238883195429, 4356.28121359972, 4374.993751437188, 4395.428594282723, 4429.11417716458, 4519.389882365905, 4524.2082635538645, 4528.932066019012, 4533.410656614685, 4574.679772415899, 4609.907801844011, 4734.4081989751285, 4735.573798358164, 4843.588294994895, 4860.854174374775, 4918.680285781413, 4985.152524070989, 4989.750512474435, 4991.401031876198, 5026.52248036436, 4865.245886887538, 4869.537393947569, 4877.853664390074, 4883.633727470383, 4933.136701077226, 4720.221163507983, 4811.422629284508, 4818.855434336975, 5076.18780995039, 5125.74371281427, 4974.701517908792, 4979.402471703419, 5064.063148317573, 5180.352455943007, 5216.686998780086, 4935.16102262609, 4965.0, 4965.255211718271, 4969.130402179532, 5021.748912554284, 4915.680480768881, 4949.084419382426, 4958.504149585013, 4966.428860681068, 5020.548150666312, 4571.38286331341, 4671.0, 4676.649251306234, 4731.645126615449, 4843.370361853077, 4958.181899986462, 4985.775640096132, 4991.900161996812, 4998.400191976986, 5040.697558146377, 4871.391076115486, 4890.364252647133, 4896.045271172087, 4899.3385892904, 4939.753012349296], "unit": "ms", "name": "dojo.html", "value": 4631.029936060182}, {"lowerIsBetter": false, "replicates": [572.3703925681754, 576.685706290072, 581.1544203184367, 584.859633687915, 585.2917969257198, 28730.13809585713, 29168.85415572922, 35013.649863501356, 35330.0, 35332.0, 41001.794991025075, 41472.0, 41505.58494415055, 41515.377269340985, 41596.0, 7070.399016083614, 7844.646990885424, 8075.071366792835, 8085.636146373398, 8088.352931765474, 7161.176464706547, 7274.4180465562895, 7276.272372762708, 7276.890846637305, 9993.900060999405, 10223.693289201336, 10301.742456438611, 10304.433256170907, 10311.0, 10324.070833624972, 10176.185905127571, 10277.794444111114, 10287.074163325336, 10301.639442619473, 10312.1234695051, 7163.212046674862, 7320.707171713125, 10244.334118282362, 10513.84229236562, 10520.053195212467, 38969.22061558753, 39361.40957885634, 39404.0, 39474.407883881766, 39508.20983580312, 2819.154253723895, 2851.3441908360987, 2965.988016812223, 3040.2095455181593, 3586.8385922633543, 29337.41325173506, 29641.851790741122, 29667.70332296671, 29701.851490742625, 29790.404191916256, 3522.947155792665, 3586.659267369596, 3589.4974703541525, 3632.3098611263777, 3718.0518967663343, 224403.0, 227194.0, 227389.0, 229817.0, 229859.0, 52528.212076818876, 58712.41287587155, 59174.40825591775, 59193.0, 59262.0, 49614.75192624014, 62617.68691156515, 63449.36550634527, 63458.0, 63490.68254658697, 13453.125546839425, 13786.448542058206, 13807.654808629664, 13809.585712428643, 13815.792763108562, 10222.693319200436, 10354.068133867837, 10356.896431035744, 10361.74095647615, 10363.740906477398, 19257.332496187933, 19695.212191512466, 19817.801821981884, 19878.0, 19908.90045549792, 7602.619869006528, 7830.960845195737, 7893.368530517545, 7930.881036784453, 7971.561564113914, 871.6164887449502, 882.5322579032994, 960.0879164793474, 978.8972157923458, 1025.9538320775582, 26424.603630945552, 26851.462970740475, 27016.459670806475, 27070.0, 27084.59373109405, 934.7336009237334, 939.4973689076448, 1078.7033565769477, 1081.5781845080426, 1094.3105843318658, 13515.324233788271, 13671.726565468634, 13748.106373085717, 13770.518031868836, 13790.517331893336, 341787.0, 345773.0, 346237.0, 347451.0, 347913.0, 41667.0, 42469.362959555634, 49696.0, 50274.0, 54395.0, 1210.195220178589, 1211.8485189351331, 1212.8362671039297, 1227.7114878003663, 1233.7409144079663, 26557.14921336357, 27532.862335688194, 28013.719862801925, 28128.156155315373, 28306.433871322046, 40934.59065409308, 41550.58449415588, 41565.37651935163, 41632.583674162874, 41634.375484368364, 258381.0, 263564.0, 266302.0328170474, 267556.0, 267842.0, 30266.84866575653, 30267.545986809775, 30632.540511892785, 30641.693583064774, 30647.080587582408, 39005.0, 39238.0, 40310.79844600758, 40334.596654033085, 40418.1916361677, 34367.82816085903, 34385.312293753486, 34733.30533389369, 34792.47811282782, 38220.80889595534, 34522.13694657654, 34749.05399813546, 35111.297774044884, 35273.47089793706, 35332.0, 35291.823540882135, 35579.110522236115, 37858.81070594629, 38687.41968870525, 39180.608193917695, 29516.262093446978, 30791.692083078884, 31001.8449907749, 31238.375232495677, 31573.684263157073, 23892.64161037551, 23980.160694375612, 24322.51354972926, 24518.38704032342, 25438.618420723335], "unit": "ms", "name": "ext.html", "value": 17764.838509601184}, {"lowerIsBetter": false, "replicates": [340.63041599864147, 341.5116383571492, 343.73704116350996, 344.1671155802957, 349.95275637788893, 12319.384030798446, 12598.0, 14725.705485890288, 14964.625884352883, 16622.83377166228, 13487.460501579924, 13885.375158117884, 15025.398984040625, 15809.60475988101, 15825.366985320603, 4934.876628084291, 4989.226669866168, 5073.112205364065, 5073.315102461157, 5141.948580514184, 3339.599248090233, 3450.9827450862713, 5125.051865404912, 5209.869753256161, 5359.1425371940495, 5284.8150314739, 5316.601254905898, 5325.547328477065, 5341.946580534183, 5357.196420536911, 5341.359036915575, 5417.51242388185, 5666.744996475169, 5682.857928551819, 5689.943100568983, 5037.546620804109, 5047.192449208109, 5049.242613607951, 5050.671706339076, 5058.519440653132, 11869.88130118705, 11876.346800925945, 11885.5840045598, 11929.28424294545, 14494.202818844959, 1775.7336399540043, 1812.0758413209226, 1855.3042609021618, 1883.9340623078126, 1906.733057371969, 8851.60167792451, 8863.157999989991, 8926.419782714103, 9066.184043436057, 9122.635094596208, 1752.535578071812, 1752.9123543822886, 1764.4882983934644, 1792.3010026089835, 1815.9182836772377, 53435.46564534383, 55911.0, 55918.0, 56440.43559564352, 56447.0, 9694.0, 9847.409155450696, 9874.308798384187, 9897.257705672104, 9919.2560557957, 12466.75066498683, 12467.93766031164, 12512.68718282032, 12516.436760345807, 12518.06114541413, 7060.117485314336, 7096.432285417154, 7113.110861142357, 7129.073220481304, 7135.250798666169, 6690.397864192246, 6722.361375669401, 6730.226024007302, 6744.5278830482375, 6747.122874026345, 4103.117829666636, 4173.8956526087095, 4182.142660754538, 4216.3464662977285, 4223.72545784523, 1519.5061604978425, 1588.801399825022, 1626.8047834259964, 1667.84989350959, 1691.4249155287262, 843.8227972125923, 863.2575984653193, 887.1970866365949, 941.9105185007413, 996.9052939970691, 12782.680432989064, 14736.778948315783, 14835.629109272355, 14888.776668349983, 15781.842181578268, 779.742684913977, 779.9977029517044, 783.0094929913664, 803.1566854802551, 851.6040041380787, 8225.79435514105, 8385.413021088465, 8529.275011623957, 8618.870716939251, 8681.609327580274, 338181.0, 339004.0, 339609.0, 344495.0, 345881.0, 37518.812405937795, 49584.75207623939, 60680.393196068355, 61586.0, 62599.0, 1054.9261551691309, 1058.7406085508946, 1099.9395033273088, 1138.408027825526, 1139.641013080877, 14128.434862605793, 14179.574612761633, 14187.574372768833, 14206.21865797391, 14944.402223910922, 29318.853405732836, 29547.55678664865, 31916.6808331923, 33185.33629327352, 33251.667483324854, 40661.79669101635, 41773.0, 42123.7893810529, 42676.573234267256, 45313.09373812571, 8410.789730256793, 8764.868526972228, 8770.429922055046, 8775.868361974448, 8789.516576588348, 10395.688129356131, 10444.06003459662, 11631.360275184947, 13241.3379331035, 16456.094914779802, 12556.748865022832, 12970.870291296966, 13127.212367257995, 13337.866621333662, 13469.0, 2326.674265602783, 2344.355302291883, 6086.6348019119, 12876.678083047998, 12979.106268119715, 12250.693732656755, 12551.497940082294, 12561.937190314355, 12634.178778379375, 12903.741925161257, 8384.413091083565, 8658.56707164652, 8702.608382622924, 8818.074102219174, 8828.690995815115, 9439.858402123837, 9562.330636855353, 11078.390688512209, 13329.266890321125, 13950.23273719955], "unit": "ms", "name": "jquery.html", "value": 7722.893233133014}, {"lowerIsBetter": false, "replicates": [1187.6496433552102, 1379.9793003104955, 1443.1629654800213, 1520.7186670465965, 1676.7820183376166, 5784.76860925563, 6245.906311405332, 6393.808185754435, 6396.584222025571, 6397.0404439334125, 6530.70611822468, 6538.150040494741, 6557.278699343068, 6598.769043083493, 6603.801885943418, 1744.1105036431447, 1778.5820332221917, 2061.5876824635056, 2077.854550181488, 2083.2292051940804, 2081.8646787958733, 2111.3876975677035, 2111.9049642766113, 2112.1234687604624, 2116.9894150529226, 2046.2428901306537, 2047.1504325704814, 2053.887036213008, 2095.4551816527737, 2098.8320934325293, 1987.1653905359783, 2079.064421010544, 2097.821685156748, 2107.6206282869002, 2111.144986280551, 2097.140172529271, 2115.968260476094, 2119.73503312086, 2119.8516103872735, 2120.236714782677, 6783.694733736994, 6794.252632210502, 6840.794776156723, 6844.965775171092, 6847.554908930903, 4025.5974402559805, 4080.10237747695, 4089.9591004090175, 4110.157417729388, 4117.21772863158, 2709.4310194859104, 2818.2954261434643, 2824.8587570621385, 2849.7292757188243, 2853.0299698102535, 758.3175142371854, 897.0715309654477, 912.8721978922956, 925.791696868206, 938.549496241801, 8872.689455869013, 9008.729738107868, 9023.142801433918, 9032.187103160748, 9048.502332371718, 3963.445117683469, 3970.622790834866, 4035.435039094529, 4036.37436197384, 4046.919061618751, 7824.21757824213, 7825.060992680801, 7828.334591559781, 7830.373570114377, 7848.372130229568, 4127.525334586501, 4144.295469770086, 4147.3778933160265, 4153.626173644387, 4157.230912281238, 3799.3351163546267, 3801.2207497462955, 3802.9429558556644, 3806.9428958565645, 3811.961880381161, 3350.2294472271515, 3353.9161520961684, 3363.9495407568907, 3373.4433818420175, 3378.3750006248924, 1065.0680654427376, 1065.717584840018, 1070.983935240972, 1074.2426589254712, 1086.4839201379439, 898.0, 980.2648013989508, 1156.1271240213584, 1171.472837223253, 1172.8299396587447, 6422.74309027643, 6444.8388790280615, 6489.253735820441, 6491.7078731457195, 6497.772577959749, 1029.505837198149, 1032.566322144701, 1034.906858382749, 1045.3936716704293, 1070.8755806403246, 5129.563987061141, 5140.845774626767, 5144.331236939249, 5154.046501397253, 5158.535731784157, 7108.573485590778, 7361.263873612703, 7707.653155608011, 7721.92278077212, 7865.567393793396, 7485.25147485258, 7531.397488201041, 7550.471466997367, 7575.053118360205, 7607.505512141693, 6319.6208227506495, 6370.777022804273, 6394.23269207698, 6394.360563943662, 6394.968025159845, 6211.689415529296, 6330.272018717907, 6345.873082538231, 6410.583312084699, 6424.421802037839, 7134.108236470442, 7175.497715159889, 7263.201047884623, 7268.67290971897, 7292.978982942286, 7324.340809327186, 7439.92560074414, 7443.069616297963, 7446.515976461513, 7465.141508726566, 5707.286589176353, 5785.942140578709, 5786.797462088806, 5795.913061304168, 5798.6810725410505, 5961.2846458425265, 6532.281449040506, 6551.279359270381, 6564.868702625825, 6608.636524991171, 6203.045076726393, 6211.409916057967, 6232.220972378453, 6253.187085678833, 6299.559030867796, 5928.733207005781, 5990.550708696778, 5991.730372133352, 6001.039833626599, 6169.722362493609, 6201.10084037821, 6220.315765265726, 6234.220722409699, 6236.6258024518675, 6241.937580624136, 5575.944240557705, 5701.40135285789, 5723.8569035774435, 5737.225474560881, 5738.282714660668, 5625.296837895263, 5717.456841600041, 5720.885582288248, 5755.5683323750045, 5790.131480277992], "unit": "ms", "name": "mootools.html", "value": 3958.0939545196375}, {"lowerIsBetter": false, "replicates": [311.8970739655914, 316.54259594885383, 321.7184963157238, 322.9192701824542, 324.336731384319, 5230.424653288135, 5234.42421333653, 5371.462853714636, 5373.81191658292, 5464.480874316943, 5146.665466744659, 5293.682379057259, 5319.6808191508535, 5321.467853214686, 5326.041312563737, 3938.4092386142165, 4032.3951407288846, 4166.833326666937, 4167.562405947362, 4172.207280616673, 4068.3694027425795, 4160.45914031177, 4169.749815011094, 4170.603792639695, 4172.5410204877435, 4118.608732170439, 4130.359794231899, 4131.834726610932, 4132.0, 4140.544540100586, 4128.62842344189, 4130.772807495571, 4135.60711732385, 4136.565660605623, 4141.834326626931, 3625.6374362563797, 3628.2017956049626, 3628.8367023483743, 3634.000649821294, 3637.8181090945345, 4939.407271127488, 5065.265536497224, 5110.872228194287, 5118.0019896120275, 5129.05112554175, 4744.14605371033, 4744.4069491313585, 4748.264019077049, 4749.358836557055, 4753.33453316536, 5352.759125839347, 5530.806421775219, 5649.4633009864, 5651.2935883014625, 5652.971735141339, 3824.2542704172697, 3928.4696565963513, 3929.842806287745, 3953.6244056814558, 3960.049588098864, 5854.736536855852, 5930.406959304079, 5932.9406705932815, 5939.1388248704125, 5941.524678025704, 4053.452783874139, 4054.4729185205733, 4054.8175332110127, 4054.9659836741444, 4058.5332686740812, 4035.757854528738, 4112.897177570525, 4120.587941205916, 4120.835166593362, 4126.546079931205, 4718.245080787057, 4719.843638308636, 4722.858314250578, 4724.031573527419, 4725.054989002145, 5626.437356264422, 5628.0713682242795, 5629.127485239795, 5630.5495560355075, 5635.408282130317, 1433.4911106557022, 1446.7251222267735, 1447.5874375802846, 1448.4278709909527, 1449.3188201545256, 971.5967873332629, 972.3436680240809, 976.3214565876648, 998.8701468809008, 999.020959459719, 4965.751712414365, 4985.725785081783, 4990.351254336985, 5000.774965126578, 5001.8499445016705, 5840.591158618856, 5863.501602363762, 5864.970675146682, 5868.853278668067, 5876.529877609781, 4964.528369804862, 4972.900541989212, 4976.402831660224, 4978.0, 4981.427135879348, 3081.6764239754953, 3143.292759129223, 3162.0355791483357, 3165.382750363657, 3172.587563616761, 5523.28197334344, 5534.363548191929, 5536.031194541019, 5550.72246387679, 5557.360903496069, 6002.669853158118, 6003.909941350883, 6018.277806663141, 6018.518518518508, 6029.698515074228, 5528.585356098309, 5536.2249285100115, 5539.501444869981, 5547.750351234285, 5551.000819852466, 5632.352279487911, 5691.8292451226525, 5909.527237820878, 5919.052951527735, 5938.168656388196, 5596.132599447093, 5614.0, 5735.082386818089, 5772.855678607901, 5776.913346299725, 5536.4186760389575, 5584.246126772996, 5593.328800543798, 5596.0, 5600.85997850057, 4152.4601801765575, 4194.475690538683, 4201.18076974987, 4203.390508376329, 4205.537390886939, 5728.598998070095, 5842.941570584239, 5842.948269311395, 5927.940720592739, 5930.0, 5692.573057020657, 5696.287964004499, 5698.743556539883, 5699.629524080921, 5699.772009119589, 5683.2895888014, 5687.260656114679, 5687.260656114844, 5688.431156884279, 5697.088465845445, 5387.81142660005, 5526.253955716088, 5569.749361278671, 5571.1086226203615, 5579.693116878449, 5715.028445164249, 5716.9709452298985, 5724.542036637143, 5725.427457254241, 5729.770809167587, 5558.749856256397, 5558.944410556004, 5562.610617256753, 5566.4990150886615, 5572.832815015556], "unit": "ms", "name": "prototype.html", "value": 4246.714198025671}, {"lowerIsBetter": false, "replicates": [652.6019128331718, 760.1979911193696, 760.8972788673527, 766.7009866152201, 792.8335049639571, 11095.500702468387, 11366.60216892409, 11386.259893106942, 11386.886131138686, 11415.31508109514, 11428.08575313975, 11433.771324573525, 11435.142364322668, 11437.027852632536, 11823.467943942522, 616.1066453642214, 622.1756173070677, 781.2968328504335, 787.6455594982252, 795.399473397584, 794.9284564389204, 797.2625321577547, 797.4975765267902, 798.5967086621248, 803.7749430159536, 832.883396324515, 833.9166083391673, 839.0518713853337, 840.7351684219482, 840.7645859159414, 645.0710976194289, 654.7937399719074, 818.3657665309373, 831.5468069901918, 832.7585000349891, 610.8625559249133, 611.2359550561798, 611.9841063834059, 612.3111499562991, 613.2824595223599, 11244.0, 11393.202475826696, 11421.086313094933, 11432.599859004895, 11443.942780286045, 10832.40421776802, 11810.350430726307, 11895.82156267648, 12077.637670869888, 12102.636920892388, 9375.249980001583, 9376.484293363863, 9415.670451534232, 9423.199028082621, 9451.52742362886, 3277.5575297334794, 3303.587051618548, 3332.350191712617, 3340.3820293245585, 3414.26593282443, 40873.79563102195, 40889.591104088875, 40951.1809763806, 41005.384919226235, 42286.0, 9454.149126578503, 9533.713988580354, 9579.281553883488, 9581.616735330508, 9598.760030999141, 16296.185190740416, 16304.940178888572, 16335.836641633668, 16346.528812406941, 16362.38201887716, 6202.131701561785, 6214.098955651405, 6254.124422580842, 6264.812055638247, 6374.74501019954, 3641.4537819326783, 3645.708343332527, 3665.52348194733, 3668.5230919980763, 3682.429223470313, 2721.7958653101095, 2765.5713364428548, 2767.4741799058115, 2768.1280396674983, 2768.6123942648046, 498.68831980012493, 501.66137856946415, 513.5916946027917, 515.9638825282194, 517.3688100517363, 516.2591680937866, 552.5524325296523, 584.8917950179231, 613.0, 656.0978654350268, 8136.003037387842, 8747.650093996295, 8825.38222324444, 8928.732138035739, 9000.60413386029, 569.6354333226739, 582.7325566891993, 624.5565648389694, 624.5877720704405, 633.1547384242089, 3683.4474828775897, 3804.7907365095184, 3841.8271177797064, 3866.6906647468136, 3881.6700580450415, 48544.514554854, 48574.75712621414, 50590.24114638283, 50627.24059139116, 50865.745671271405, 39646.80176599098, 39744.0, 39791.40312895309, 40048.19903601912, 40116.79941600332, 36115.638843611756, 36831.81584092062, 37333.43999840005, 37356.62643373586, 37396.62603373932, 7833.686652534063, 8051.557164356017, 8118.431709780259, 8287.40864981419, 8423.410361274651, 30600.387992240478, 31116.0, 31503.212419688774, 31522.527162092127, 32579.0, 39934.201315974096, 40143.3978490317, 40581.39127913024, 40790.79604602077, 40909.59090409177, 10317.845232321371, 10394.428306442916, 10409.895901040893, 10435.478226088513, 10500.684979450629, 11470.369129697612, 11647.242929209575, 11673.824892626788, 11850.05199584014, 12000.1599888007, 10619.522121504397, 10621.787564248827, 10782.903676959106, 11102.056325212125, 11468.0, 11050.778984420427, 11128.109751220045, 11135.0, 11173.0, 11578.421078946187, 10111.0, 10572.365658060233, 10822.350658960488, 10849.457527123453, 11011.61459348919, 9058.728238152866, 9500.239980801658, 9511.762205944906, 9536.141747242782, 9611.0, 8959.507227102571, 9076.591553379982, 9129.817403651758, 9454.101860323259, 9507.239420846454], "unit": "ms", "name": "yui.html", "value": 5760.88062028521}], "name": "dromaeo_css", "value": 6283.220961012314}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 112.0, 107.0, 110.0, 112.0, 111.0, 101.0, 112.0, 116.0, 111.0], "unit": "ms", "name": "ai-astar", "value": 110.3}, {"lowerIsBetter": true, "replicates": [152.0, 130.0, 157.0, 164.0, 129.0, 152.0, 160.0, 131.0, 167.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 147.1}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 162.0, 163.0, 161.0, 161.0, 162.0, 164.0, 163.0, 165.0], "unit": "ms", "name": "audio-dft", "value": 162.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 81.0, 92.0, 72.0, 72.0, 72.0, 94.0, 88.0, 72.0], "unit": "ms", "name": "audio-fft", "value": 78.9}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 131.0, 91.0, 91.0, 92.0, 124.0, 92.0, 92.0, 136.0], "unit": "ms", "name": "audio-oscillator", "value": 103.1}, {"lowerIsBetter": true, "replicates": [109.0, 110.0, 110.0, 109.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [147.0, 147.0, 149.0, 147.0, 148.0, 147.0, 148.0, 147.0, 146.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.2}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 96.0, 96.0, 96.0, 95.0, 96.0, 96.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.8}, {"lowerIsBetter": true, "replicates": [71.0, 69.0, 70.0, 70.0, 70.0, 69.0, 69.0, 78.0, 67.0, 67.0], "unit": "ms", "name": "json-parse-financial", "value": 70.0}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 69.0, 69.0, 69.0, 68.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [82.0, 84.0, 83.0, 82.0, 92.0, 83.0, 83.0, 84.0, 84.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [120.0, 118.0, 123.0, 119.0, 125.0, 122.0, 129.0, 127.0, 119.0, 122.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 122.4}, {"lowerIsBetter": true, "replicates": [148.0, 144.0, 143.0, 145.0, 147.0, 136.0, 145.0, 144.0, 147.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 143.8}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 71.0, 72.0, 68.0, 68.0, 68.0, 69.0, 67.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.8}], "name": "kraken", "value": 1512.1}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.5322976287817], "unit": "score", "name": "Richards", "value": 215.87172999999993}, {"lowerIsBetter": false, "replicates": [190.94901661256444], "unit": "score", "name": "DeltaBlue", "value": 346.2599660000002}, {"lowerIsBetter": false, "replicates": [279.9552071668533], "unit": "score", "name": "Encrypt", "value": 950.7985320000004}, {"lowerIsBetter": false, "replicates": [5020.0], "unit": "score", "name": "Decrypt", "value": 53.0241035856574}, {"lowerIsBetter": false, "replicates": [1984.126984126984], "unit": "score", "name": "RayTrace", "value": 372.9544560000001}, {"lowerIsBetter": false, "replicates": [794.2811755361398], "unit": "score", "name": "Earley", "value": 839.0769169999999}, {"lowerIsBetter": false, "replicates": [11964.285714285714], "unit": "score", "name": "Boyer", "value": 55.704370149253705}, {"lowerIsBetter": false, "replicates": [26025.641025641027], "unit": "score", "name": "RegExp", "value": 35.003364532019674}, {"lowerIsBetter": false, "replicates": [619.6660482374768], "unit": "score", "name": "Splay", "value": 131.50793113772448}, {"lowerIsBetter": false, "replicates": [4822.115384615385], "unit": "score", "name": "NavierStokes", "value": 307.7487537387835}], "name": "v8_7", "value": 19884.508569066173}]} 22:43:38 INFO - RETURN: dromaeo_css: 6283.22 22:43:38 INFO - RETURN: kraken: 1512.10 22:43:38 INFO - RETURN: v8_7: 19884.51 22:43:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,203,35]]", "result": "19884.51"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,203,35]]", "result": "1512.10"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,203,35]]", "result": "6283.22"}}} 22:43:38 INFO - Return code: 0 22:43:38 INFO - # TBPL SUCCESS # 22:43:38 INFO - Running post-action listener: _resource_record_post_action 22:43:38 INFO - Running post-run listener: _resource_record_post_run 22:43:39 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511082496; Read time: 32; Write time: 395392 22:43:39 INFO - install - Wall time: 15s; CPU: 13.0%; Read bytes: 0; Write bytes: 145104896; Read time: 0; Write time: 161372 22:43:39 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 270389248; Read time: 0; Write time: 155700 22:43:39 INFO - Running post-run listener: _upload_blobber_files 22:43:39 INFO - Blob upload gear active. 22:43:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 22:43:39 INFO - Copying logs to upload dir... 22:43:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1264.902862 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2015-11-22 22:43:39.178011) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-22 22:43:39.181583) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010061 build_url: 'https://queue.taskcluster.net/v1/task/fXWLJ3xITP-lvbfgSmvL3w/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-22 22:43:39.233004) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:43:39.233336) ========= 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=0c96bf5caf0e090009e1a122000001b2-1448259008.551406-794559360 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004508 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-22 22:43:39.282732) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 22:43:39.283059) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-22 22:43:39.283356) ========= ========= Total master_lag: 0.23 =========