builder: mozilla-inbound_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-039 starttime: 1447783010.62 results: success (0) buildid: 20151117093002 builduid: 56c9242244d04739be1718c3bba69c0d revision: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.619629) ========= master: http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.620392) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.620750) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006559 basedir: '/builds/slave/test' ========= master_lag: 0.07 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.693789) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.694108) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.742582) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.743096) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004676 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.797390) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.797693) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.798070) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:50.798398) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-17 09:56:51-- 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% 216M=0s 2015-11-17 09:56:51 (216 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.195629 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.013227) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.013621) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.015488 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.068228) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.068612) ========= bash -c 'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/mozilla-inbound --rev 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 --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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-17 09:56:52,077 truncating revision to first 12 chars 2015-11-17 09:56:52,077 Setting DEBUG logging. 2015-11-17 09:56:52,077 attempt 1/10 2015-11-17 09:56:52,077 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/mozilla-inbound/06188c6531b5?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 09:56:52,314 unpacking tar archive at: mozilla-inbound-06188c6531b5/testing/mozharness/ program finished with exit code 0 elapsedTime=0.510307 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.608520) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.608826) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.637924) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.638233) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 09:56:51.638696) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-17 09:56:51.639018) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-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', 'Mozilla-Inbound-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 09:56:52 INFO - MultiFileLogger online at 20151117 09:56:52 in /builds/slave/test 09:56:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Inbound-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Inbound-Non-PGO 09:56:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:56:52 INFO - {'append_to_log': False, 09:56:52 INFO - 'base_work_dir': '/builds/slave/test', 09:56:52 INFO - 'blob_upload_branch': 'Mozilla-Inbound-Non-PGO', 09:56:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:56:52 INFO - 'branch': 'Mozilla-Inbound-Non-PGO', 09:56:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:56:52 INFO - 'config_files': ('talos/linux_config.py',), 09:56:52 INFO - 'default_actions': ('clobber', 09:56:52 INFO - 'read-buildbot-config', 09:56:52 INFO - 'download-and-extract', 09:56:52 INFO - 'populate-webroot', 09:56:52 INFO - 'create-virtualenv', 09:56:52 INFO - 'install', 09:56:52 INFO - 'run-tests'), 09:56:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:56:52 INFO - 'download_minidump_stackwalk': True, 09:56:52 INFO - 'download_symbols': 'ondemand', 09:56:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:56:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:56:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:56:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:56:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:56:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:56:52 INFO - 'installer_path': 'installer.exe', 09:56:52 INFO - 'log_level': 'info', 09:56:52 INFO - 'log_name': 'talos', 09:56:52 INFO - 'log_to_console': True, 09:56:52 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 09:56:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 09:56:52 INFO - 'opt_config_files': (), 09:56:52 INFO - 'pip_index': False, 09:56:52 INFO - 'sps_profile': False, 09:56:52 INFO - 'sps_profile_interval': 0, 09:56:52 INFO - 'suite': 'dromaeojs', 09:56:52 INFO - 'system_bits': '64', 09:56:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:56:52 INFO - 'title': 'talos-linux64-ix-039', 09:56:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:56:52 INFO - 'use_talos_json': True, 09:56:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:56:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:56:52 INFO - 'work_dir': 'build'} 09:56:52 INFO - ##### 09:56:52 INFO - ##### Running clobber step. 09:56:52 INFO - ##### 09:56:52 INFO - Running pre-action listener: _resource_record_pre_action 09:56:52 INFO - Running main action method: clobber 09:56:52 INFO - rmtree: /builds/slave/test/build 09:56:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:56:53 INFO - Running post-action listener: _resource_record_post_action 09:56:53 INFO - ##### 09:56:53 INFO - ##### Running read-buildbot-config step. 09:56:53 INFO - ##### 09:56:53 INFO - Running pre-action listener: _resource_record_pre_action 09:56:53 INFO - Running main action method: read_buildbot_config 09:56:53 INFO - Using buildbot properties: 09:56:53 INFO - { 09:56:53 INFO - "properties": { 09:56:53 INFO - "buildnumber": 2881, 09:56:53 INFO - "product": "firefox", 09:56:53 INFO - "script_repo_revision": "production", 09:56:53 INFO - "builddir": "mozilla-inbound_ubuntu64_hw_test-dromaeojs", 09:56:53 INFO - "repository": "", 09:56:53 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-inbound talos dromaeojs", 09:56:53 INFO - "buildid": "20151117093002", 09:56:53 INFO - "slavename": "talos-linux64-ix-039", 09:56:53 INFO - "pgo_build": "False", 09:56:53 INFO - "basedir": "/builds/slave/test", 09:56:53 INFO - "project": "", 09:56:53 INFO - "platform": "ubuntu64_hw", 09:56:53 INFO - "master": "http://buildbot-master104.bb.releng.scl3.mozilla.com:8201/", 09:56:53 INFO - "slavebuilddir": "test", 09:56:53 INFO - "scheduler": "tests-mozilla-inbound-linux64-talos", 09:56:53 INFO - "branch": "mozilla-inbound", 09:56:53 INFO - "repo_path": "integration/mozilla-inbound", 09:56:53 INFO - "stage_platform": "linux64", 09:56:53 INFO - "builduid": "56c9242244d04739be1718c3bba69c0d", 09:56:53 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 09:56:53 INFO - }, 09:56:53 INFO - "sourcestamp": { 09:56:53 INFO - "repository": "", 09:56:53 INFO - "hasPatch": false, 09:56:53 INFO - "project": "", 09:56:53 INFO - "branch": "mozilla-inbound-linux64-talos", 09:56:53 INFO - "changes": [ 09:56:53 INFO - { 09:56:53 INFO - "category": null, 09:56:53 INFO - "files": [ 09:56:53 INFO - { 09:56:53 INFO - "url": null, 09:56:53 INFO - "name": "https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 09:56:53 INFO - } 09:56:53 INFO - ], 09:56:53 INFO - "repository": "", 09:56:53 INFO - "rev": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882", 09:56:53 INFO - "who": "wlachance@mozilla.com", 09:56:53 INFO - "when": 1447782921, 09:56:53 INFO - "number": 6672864, 09:56:53 INFO - "comments": "Bug 1222588 - Fix counter ingestion in Perfherder;r=jmaher", 09:56:53 INFO - "project": "", 09:56:53 INFO - "at": "Tue 17 Nov 2015 09:55:21", 09:56:53 INFO - "branch": "mozilla-inbound-linux64-talos", 09:56:53 INFO - "revlink": "", 09:56:53 INFO - "properties": [ 09:56:53 INFO - [ 09:56:53 INFO - "buildid", 09:56:53 INFO - "20151117093002", 09:56:53 INFO - "Change" 09:56:53 INFO - ], 09:56:53 INFO - [ 09:56:53 INFO - "builduid", 09:56:53 INFO - "56c9242244d04739be1718c3bba69c0d", 09:56:53 INFO - "Change" 09:56:53 INFO - ], 09:56:53 INFO - [ 09:56:53 INFO - "pgo_build", 09:56:53 INFO - "False", 09:56:53 INFO - "Change" 09:56:53 INFO - ] 09:56:53 INFO - ], 09:56:53 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 09:56:53 INFO - } 09:56:53 INFO - ], 09:56:53 INFO - "revision": "06188c6531b5b06fc9bd2cdcd25eaf5c1b778882" 09:56:53 INFO - } 09:56:53 INFO - } 09:56:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 09:56:53 INFO - Running post-action listener: _resource_record_post_action 09:56:53 INFO - ##### 09:56:53 INFO - ##### Running download-and-extract step. 09:56:53 INFO - ##### 09:56:53 INFO - Running pre-action listener: _resource_record_pre_action 09:56:53 INFO - Running main action method: download_and_extract 09:56:53 INFO - mkdir: /builds/slave/test/build/tests 09:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:53 INFO - https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/test_packages.json 09:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/test_packages.json 09:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:56:59 INFO - Downloaded 1302 bytes. 09:56:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:56:59 INFO - Using the following test package requirements: 09:56:59 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 09:56:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'jsshell-linux-x86_64.zip'], 09:56:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 09:56:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 09:56:59 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 09:56:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 09:56:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 09:56:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 09:56:59 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 09:56:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 09:56:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:56:59 INFO - https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:56:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:56:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:56:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:56:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:00 INFO - Downloaded 21277459 bytes. 09:57:00 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 09:57:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:00 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 09:57:01 INFO - Return code: 0 09:57:01 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 09:57:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:01 INFO - https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 09:57:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:05 INFO - Downloaded 21277459 bytes. 09:57:05 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 09:57:05 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 09:57:05 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 09:57:07 INFO - Return code: 0 09:57:07 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')]} 09:57:07 INFO - https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 09:57:07 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:07 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:07 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:07 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:07 INFO - Downloaded 11130997 bytes. 09:57:07 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 09:57:07 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 09:57:07 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 09:57:08 INFO - Return code: 0 09:57:08 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')]} 09:57:08 INFO - https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 09:57:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/1kB_WI6ETIq36E8azE_V2g/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 09:57:10 INFO - Downloaded 55665705 bytes. 09:57:10 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:10 INFO - mkdir: /builds/slave/test/properties 09:57:10 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:57:10 INFO - Writing to file /builds/slave/test/properties/build_url 09:57:10 INFO - Contents: 09:57:10 INFO - build_url:https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 09:57:10 INFO - Running post-action listener: _resource_record_post_action 09:57:10 INFO - Running post-action listener: set_extra_try_arguments 09:57:10 INFO - ##### 09:57:10 INFO - ##### Running populate-webroot step. 09:57:10 INFO - ##### 09:57:10 INFO - Running pre-action listener: _resource_record_pre_action 09:57:10 INFO - Running main action method: populate_webroot 09:57:10 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:57:10 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:57:10 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 09:57:10 INFO - '../fennec_ids.txt'], 09:57:10 INFO - 'tests': ['tcheck2']}, 09:57:10 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:57:10 INFO - '--tppagecycles', 09:57:10 INFO - '7'], 09:57:10 INFO - 'tests': ['tsvgm']}}, 09:57:10 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:57:10 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:57:10 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:10 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 09:57:10 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:10 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:57:10 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'tests': ['damp', 'tps']}, 09:57:10 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['damp', 'tps']}, 09:57:10 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:57:10 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:57:10 INFO - 'other': {'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'other_l64': {'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'other_nol64': {'tests': ['a11yr', 09:57:10 INFO - 'ts_paint', 09:57:10 INFO - 'tpaint', 09:57:10 INFO - 'sessionrestore', 09:57:10 INFO - 'sessionrestore_no_auto_restore']}, 09:57:10 INFO - 'svgr': {'tests': ['tsvgx', 09:57:10 INFO - 'tsvgr_opacity', 09:57:10 INFO - 'tart', 09:57:10 INFO - 'tscrollx', 09:57:10 INFO - 'cart']}, 09:57:10 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['tsvgx', 09:57:10 INFO - 'tsvgr_opacity', 09:57:10 INFO - 'tart', 09:57:10 INFO - 'tscrollx', 09:57:10 INFO - 'cart']}, 09:57:10 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'tests': ['tp5o']}, 09:57:10 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'talos_options': ['--e10s'], 09:57:10 INFO - 'tests': ['tp5o']}, 09:57:10 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'talos_options': ['--xperf_path', 09:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:10 INFO - 'tests': ['tp5n']}, 09:57:10 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:57:10 INFO - 'talos_options': ['--e10s', 09:57:10 INFO - '--xperf_path', 09:57:10 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:57:10 INFO - 'tests': ['tp5n']}}, 09:57:10 INFO - 'talos.zip': {'path': '', 09:57:10 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:57:10 INFO - Running post-action listener: _resource_record_post_action 09:57:10 INFO - ##### 09:57:10 INFO - ##### Running create-virtualenv step. 09:57:10 INFO - ##### 09:57:10 INFO - Running pre-action listener: _resource_record_pre_action 09:57:10 INFO - Running main action method: create_virtualenv 09:57:10 INFO - Creating virtualenv /builds/slave/test/build/venv 09:57:10 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 09:57:10 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:57:10 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:57:10 INFO - Using real prefix '/usr' 09:57:10 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:57:11 INFO - Installing distribute.............................................................................................................................................................................................done. 09:57:13 INFO - Installing pip.................done. 09:57:13 INFO - Return code: 0 09:57:13 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:57:13 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')]} 09:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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')]} 09:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:13 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 09:57:13 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 09:57:13 INFO - Using env: {'DISPLAY': ':0', 09:57:13 INFO - 'HOME': '/home/cltbld', 09:57:13 INFO - 'LANG': 'en_US.UTF-8', 09:57:13 INFO - 'LANGUAGE': 'en_US:en', 09:57:13 INFO - 'LOGNAME': 'cltbld', 09:57:13 INFO - 'MAIL': '/var/mail/cltbld', 09:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:13 INFO - 'MOZ_NO_REMOTE': '1', 09:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:13 INFO - 'NO_EM_RESTART': '1', 09:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:13 INFO - 'PWD': '/builds/slave/test', 09:57:13 INFO - 'SHELL': '/bin/bash', 09:57:13 INFO - 'SHLVL': '1', 09:57:13 INFO - 'TERM': 'linux', 09:57:13 INFO - 'TMOUT': '86400', 09:57:13 INFO - 'USER': 'cltbld', 09:57:13 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:13 INFO - '_': '/tools/buildbot/bin/python'} 09:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:13 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 09:57:13 INFO - Cleaning up... 09:57:13 INFO - Return code: 0 09:57:13 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:57:13 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')]} 09:57:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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')]} 09:57:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:13 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:13 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 09:57:13 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 09:57:13 INFO - Using env: {'DISPLAY': ':0', 09:57:13 INFO - 'HOME': '/home/cltbld', 09:57:13 INFO - 'LANG': 'en_US.UTF-8', 09:57:13 INFO - 'LANGUAGE': 'en_US:en', 09:57:13 INFO - 'LOGNAME': 'cltbld', 09:57:13 INFO - 'MAIL': '/var/mail/cltbld', 09:57:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:13 INFO - 'MOZ_NO_REMOTE': '1', 09:57:13 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:13 INFO - 'NO_EM_RESTART': '1', 09:57:13 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:13 INFO - 'PWD': '/builds/slave/test', 09:57:13 INFO - 'SHELL': '/bin/bash', 09:57:13 INFO - 'SHLVL': '1', 09:57:13 INFO - 'TERM': 'linux', 09:57:13 INFO - 'TMOUT': '86400', 09:57:13 INFO - 'USER': 'cltbld', 09:57:13 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:13 INFO - '_': '/tools/buildbot/bin/python'} 09:57:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:13 INFO - Downloading/unpacking psutil>=0.7.1 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:13 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 09:57:15 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 09:57:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 09:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:15 INFO - Installing collected packages: psutil 09:57:15 INFO - Running setup.py install for psutil 09:57:15 INFO - building 'psutil._psutil_linux' extension 09:57:15 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 09:57:15 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 09:57:15 INFO - building 'psutil._psutil_posix' extension 09:57:15 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 09:57:15 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 09:57:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:57:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:57:15 INFO - Successfully installed psutil 09:57:15 INFO - Cleaning up... 09:57:15 INFO - Return code: 0 09:57:15 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:57:15 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')]} 09:57:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:15 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')]} 09:57:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:15 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:15 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 09:57:15 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 09:57:15 INFO - Using env: {'DISPLAY': ':0', 09:57:15 INFO - 'HOME': '/home/cltbld', 09:57:15 INFO - 'LANG': 'en_US.UTF-8', 09:57:15 INFO - 'LANGUAGE': 'en_US:en', 09:57:15 INFO - 'LOGNAME': 'cltbld', 09:57:15 INFO - 'MAIL': '/var/mail/cltbld', 09:57:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:15 INFO - 'MOZ_NO_REMOTE': '1', 09:57:15 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:15 INFO - 'NO_EM_RESTART': '1', 09:57:15 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:15 INFO - 'PWD': '/builds/slave/test', 09:57:15 INFO - 'SHELL': '/bin/bash', 09:57:15 INFO - 'SHLVL': '1', 09:57:15 INFO - 'TERM': 'linux', 09:57:15 INFO - 'TMOUT': '86400', 09:57:15 INFO - 'USER': 'cltbld', 09:57:15 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:15 INFO - '_': '/tools/buildbot/bin/python'} 09:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:16 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:16 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 09:57:17 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:57:17 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 09:57:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:57:17 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:57:17 INFO - Installing collected packages: mozsystemmonitor 09:57:17 INFO - Running setup.py install for mozsystemmonitor 09:57:17 INFO - Successfully installed mozsystemmonitor 09:57:17 INFO - Cleaning up... 09:57:18 INFO - Return code: 0 09:57:18 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:57:18 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')]} 09:57:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:18 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')]} 09:57:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:18 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:18 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 09:57:18 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 09:57:18 INFO - Using env: {'DISPLAY': ':0', 09:57:18 INFO - 'HOME': '/home/cltbld', 09:57:18 INFO - 'LANG': 'en_US.UTF-8', 09:57:18 INFO - 'LANGUAGE': 'en_US:en', 09:57:18 INFO - 'LOGNAME': 'cltbld', 09:57:18 INFO - 'MAIL': '/var/mail/cltbld', 09:57:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:18 INFO - 'MOZ_NO_REMOTE': '1', 09:57:18 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:18 INFO - 'NO_EM_RESTART': '1', 09:57:18 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:18 INFO - 'PWD': '/builds/slave/test', 09:57:18 INFO - 'SHELL': '/bin/bash', 09:57:18 INFO - 'SHLVL': '1', 09:57:18 INFO - 'TERM': 'linux', 09:57:18 INFO - 'TMOUT': '86400', 09:57:18 INFO - 'USER': 'cltbld', 09:57:18 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:18 INFO - '_': '/tools/buildbot/bin/python'} 09:57:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:18 INFO - Downloading/unpacking blobuploader==1.2.4 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:18 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 09:57:19 INFO - Downloading blobuploader-1.2.4.tar.gz 09:57:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 09:57:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:57:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:57:19 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 09:57:19 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 09:57:19 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 09:57:19 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 09:57:19 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 09:57:19 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 09:57:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 09:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:57:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 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 09:57:20 INFO - Downloading docopt-0.6.1.tar.gz 09:57:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 09:57:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:57:20 INFO - Installing collected packages: blobuploader, requests, docopt 09:57:20 INFO - Running setup.py install for blobuploader 09:57:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:57:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:57:20 INFO - Running setup.py install for requests 09:57:21 INFO - Running setup.py install for docopt 09:57:21 INFO - Successfully installed blobuploader requests docopt 09:57:21 INFO - Cleaning up... 09:57:21 INFO - Return code: 0 09:57:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:21 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')]} 09:57:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 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')]} 09:57:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:21 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:21 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 09:57:21 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 09:57:21 INFO - Using env: {'DISPLAY': ':0', 09:57:21 INFO - 'HOME': '/home/cltbld', 09:57:21 INFO - 'LANG': 'en_US.UTF-8', 09:57:21 INFO - 'LANGUAGE': 'en_US:en', 09:57:21 INFO - 'LOGNAME': 'cltbld', 09:57:21 INFO - 'MAIL': '/var/mail/cltbld', 09:57:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:21 INFO - 'MOZ_NO_REMOTE': '1', 09:57:21 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:21 INFO - 'NO_EM_RESTART': '1', 09:57:21 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:21 INFO - 'PWD': '/builds/slave/test', 09:57:21 INFO - 'SHELL': '/bin/bash', 09:57:21 INFO - 'SHLVL': '1', 09:57:21 INFO - 'TERM': 'linux', 09:57:21 INFO - 'TMOUT': '86400', 09:57:21 INFO - 'USER': 'cltbld', 09:57:21 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:21 INFO - '_': '/tools/buildbot/bin/python'} 09:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:21 INFO - Running setup.py (path:/tmp/pip-V1MSUV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:21 INFO - Running setup.py (path:/tmp/pip-xn9tID-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:21 INFO - Running setup.py (path:/tmp/pip-IiGNVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:21 INFO - Running setup.py (path:/tmp/pip-QS21an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:21 INFO - Running setup.py (path:/tmp/pip-UfVnLv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:21 INFO - Running setup.py (path:/tmp/pip-tLdfUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:21 INFO - Running setup.py (path:/tmp/pip-NrqMor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:21 INFO - Running setup.py (path:/tmp/pip-hpjrUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:22 INFO - Running setup.py (path:/tmp/pip-l74XQ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:22 INFO - Running setup.py (path:/tmp/pip-JBAojD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:22 INFO - Running setup.py (path:/tmp/pip-O0xbYA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:22 INFO - Running setup.py (path:/tmp/pip-1_QMUp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:22 INFO - Running setup.py (path:/tmp/pip-tfmZms-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:22 INFO - Running setup.py (path:/tmp/pip-DLzsiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:22 INFO - Running setup.py (path:/tmp/pip-2iY2RQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:22 INFO - Running setup.py (path:/tmp/pip-wMyM75-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:22 INFO - Running setup.py (path:/tmp/pip-Gc0Sgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:22 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:57:22 INFO - Running setup.py install for manifestparser 09:57:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:57:22 INFO - Running setup.py install for mozcrash 09:57:22 INFO - Running setup.py install for mozdebug 09:57:22 INFO - Running setup.py install for mozdevice 09:57:23 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for mozfile 09:57:23 INFO - Running setup.py install for mozhttpd 09:57:23 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for mozinfo 09:57:23 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for mozInstall 09:57:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for mozleak 09:57:23 INFO - Running setup.py install for mozlog 09:57:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for moznetwork 09:57:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:57:23 INFO - Running setup.py install for mozprocess 09:57:23 INFO - Running setup.py install for mozprofile 09:57:24 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:57:24 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:57:24 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:57:24 INFO - Running setup.py install for mozrunner 09:57:24 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:57:24 INFO - Running setup.py install for mozscreenshot 09:57:24 INFO - Running setup.py install for moztest 09:57:24 INFO - Running setup.py install for mozversion 09:57:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:57:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:57:24 INFO - Cleaning up... 09:57:24 INFO - Return code: 0 09:57:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:24 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')]} 09:57:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 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')]} 09:57:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:24 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:24 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 09:57:24 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 09:57:24 INFO - Using env: {'DISPLAY': ':0', 09:57:24 INFO - 'HOME': '/home/cltbld', 09:57:24 INFO - 'LANG': 'en_US.UTF-8', 09:57:24 INFO - 'LANGUAGE': 'en_US:en', 09:57:24 INFO - 'LOGNAME': 'cltbld', 09:57:24 INFO - 'MAIL': '/var/mail/cltbld', 09:57:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:24 INFO - 'MOZ_NO_REMOTE': '1', 09:57:24 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:24 INFO - 'NO_EM_RESTART': '1', 09:57:24 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:24 INFO - 'PWD': '/builds/slave/test', 09:57:24 INFO - 'SHELL': '/bin/bash', 09:57:24 INFO - 'SHLVL': '1', 09:57:24 INFO - 'TERM': 'linux', 09:57:24 INFO - 'TMOUT': '86400', 09:57:24 INFO - 'USER': 'cltbld', 09:57:24 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:24 INFO - '_': '/tools/buildbot/bin/python'} 09:57:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:57:24 INFO - Running setup.py (path:/tmp/pip-hWk1hc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:57:24 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)) 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:57:24 INFO - Running setup.py (path:/tmp/pip-2orRwE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:57:24 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)) 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:57:24 INFO - Running setup.py (path:/tmp/pip-yi2NY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:57:24 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)) 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:57:24 INFO - Running setup.py (path:/tmp/pip-OqKZkg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:57:24 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)) 09:57:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:57:24 INFO - Running setup.py (path:/tmp/pip-a43jdM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:57:25 INFO - Running setup.py (path:/tmp/pip-mfAOp0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:57:25 INFO - Running setup.py (path:/tmp/pip-tJJZ5h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:57:25 INFO - Running setup.py (path:/tmp/pip-VhOvOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:57:25 INFO - Running setup.py (path:/tmp/pip-S0kvuR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:57:25 INFO - Running setup.py (path:/tmp/pip-OKLyub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:57:25 INFO - Running setup.py (path:/tmp/pip-8R2NMj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:57:25 INFO - Running setup.py (path:/tmp/pip-63jBJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:57:25 INFO - Running setup.py (path:/tmp/pip-a5F8hr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:57:25 INFO - Running setup.py (path:/tmp/pip-6gOYLr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:25 INFO - Running setup.py (path:/tmp/pip-kjCMic-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:57:25 INFO - Running setup.py (path:/tmp/pip-OyNyFc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:57:25 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)) 09:57:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:57:25 INFO - Running setup.py (path:/tmp/pip-XoQQqL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:57:25 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)) 09:57:25 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)) 09:57:25 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)) 09:57:25 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)) 09:57:25 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)) 09:57:25 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)) 09:57:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:57:25 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 09:57:25 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 09:57:25 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 09:57:25 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 09:57:25 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 09:57:25 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 09:57:27 INFO - Downloading blessings-1.5.1.tar.gz 09:57:27 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 09:57:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:57:27 INFO - Installing collected packages: blessings 09:57:27 INFO - Running setup.py install for blessings 09:57:27 INFO - Successfully installed blessings 09:57:27 INFO - Cleaning up... 09:57:27 INFO - Return code: 0 09:57:27 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:57:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:28 INFO - Reading from file tmpfile_stdout 09:57:28 INFO - Current package versions: 09:57:28 INFO - argparse == 1.2.1 09:57:28 INFO - blessings == 1.5.1 09:57:28 INFO - blobuploader == 1.2.4 09:57:28 INFO - docopt == 0.6.1 09:57:28 INFO - manifestparser == 1.1 09:57:28 INFO - mozInstall == 1.12 09:57:28 INFO - mozcrash == 0.16 09:57:28 INFO - mozdebug == 0.1 09:57:28 INFO - mozdevice == 0.47 09:57:28 INFO - mozfile == 1.2 09:57:28 INFO - mozhttpd == 0.7 09:57:28 INFO - mozinfo == 0.9 09:57:28 INFO - mozleak == 0.1 09:57:28 INFO - mozlog == 3.0 09:57:28 INFO - moznetwork == 0.27 09:57:28 INFO - mozprocess == 0.22 09:57:28 INFO - mozprofile == 0.27 09:57:28 INFO - mozrunner == 6.11 09:57:28 INFO - mozscreenshot == 0.1 09:57:28 INFO - mozsystemmonitor == 0.0 09:57:28 INFO - moztest == 0.7 09:57:28 INFO - mozversion == 1.4 09:57:28 INFO - psutil == 3.1.1 09:57:28 INFO - requests == 1.2.3 09:57:28 INFO - wsgiref == 0.1.2 09:57:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:57:28 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')]} 09:57:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:57:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:28 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')]} 09:57:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:57:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:57:28 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 0x7fbd697a9c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1d926c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1e43900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, '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': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', '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 09:57:28 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 09:57:28 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 09:57:28 INFO - Using env: {'DISPLAY': ':0', 09:57:28 INFO - 'HOME': '/home/cltbld', 09:57:28 INFO - 'LANG': 'en_US.UTF-8', 09:57:28 INFO - 'LANGUAGE': 'en_US:en', 09:57:28 INFO - 'LOGNAME': 'cltbld', 09:57:28 INFO - 'MAIL': '/var/mail/cltbld', 09:57:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:28 INFO - 'MOZ_NO_REMOTE': '1', 09:57:28 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:28 INFO - 'NO_EM_RESTART': '1', 09:57:28 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:28 INFO - 'PWD': '/builds/slave/test', 09:57:28 INFO - 'SHELL': '/bin/bash', 09:57:28 INFO - 'SHLVL': '1', 09:57:28 INFO - 'TERM': 'linux', 09:57:28 INFO - 'TMOUT': '86400', 09:57:28 INFO - 'USER': 'cltbld', 09:57:28 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:28 INFO - '_': '/tools/buildbot/bin/python'} 09:57:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 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)) 09:57:28 INFO - Cleaning up... 09:57:28 INFO - Return code: 0 09:57:28 INFO - Running post-action listener: _resource_record_post_action 09:57:28 INFO - Running post-action listener: _start_resource_monitoring 09:57:28 INFO - Starting resource monitoring. 09:57:28 INFO - ##### 09:57:28 INFO - ##### Running install step. 09:57:28 INFO - ##### 09:57:28 INFO - Running pre-action listener: _resource_record_pre_action 09:57:28 INFO - Running main action method: install 09:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:57:28 INFO - Reading from file tmpfile_stdout 09:57:28 INFO - Detecting whether we're running mozinstall >=1.0... 09:57:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:57:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:57:28 INFO - Reading from file tmpfile_stdout 09:57:28 INFO - Output received: 09:57:28 INFO - Usage: mozinstall [options] installer 09:57:28 INFO - Options: 09:57:28 INFO - -h, --help show this help message and exit 09:57:28 INFO - -d DEST, --destination=DEST 09:57:28 INFO - Directory to install application into. [default: 09:57:28 INFO - "/builds/slave/test"] 09:57:28 INFO - --app=APP Application being installed. [default: firefox] 09:57:28 INFO - mkdir: /builds/slave/test/build/application 09:57:28 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'] 09:57:28 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 09:57:42 INFO - Reading from file tmpfile_stdout 09:57:42 INFO - Output received: 09:57:42 INFO - /builds/slave/test/build/application/firefox/firefox 09:57:42 INFO - Running post-action listener: _resource_record_post_action 09:57:42 INFO - ##### 09:57:42 INFO - ##### Running run-tests step. 09:57:42 INFO - ##### 09:57:42 INFO - Running pre-action listener: _resource_record_pre_action 09:57:42 INFO - Running main action method: run_tests 09:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:57:42 INFO - Python 2.7.3 09:57:42 INFO - Return code: 0 09:57:42 INFO - grabbing minidump binary from tooltool 09:57:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:57:42 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 0x1e89b70>, '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 0x1edadc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1edb250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:57:42 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 09:57:42 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 09:57:42 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:57:42 INFO - Return code: 0 09:57:42 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 09:57:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:57:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:57:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 09:57:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:57:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] in /builds/slave/test/build 09:57:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Mozilla-Inbound-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-039 --webServer localhost 09:57:42 INFO - Using env: {'DISPLAY': ':0', 09:57:42 INFO - 'HOME': '/home/cltbld', 09:57:42 INFO - 'LANG': 'en_US.UTF-8', 09:57:42 INFO - 'LANGUAGE': 'en_US:en', 09:57:42 INFO - 'LOGNAME': 'cltbld', 09:57:42 INFO - 'MAIL': '/var/mail/cltbld', 09:57:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:57:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 09:57:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:57:42 INFO - 'MOZ_NO_REMOTE': '1', 09:57:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:57:42 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 09:57:42 INFO - 'NO_EM_RESTART': '1', 09:57:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 09:57:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:57:42 INFO - 'PWD': '/builds/slave/test', 09:57:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:57:42 INFO - 'SHELL': '/bin/bash', 09:57:42 INFO - 'SHLVL': '1', 09:57:42 INFO - 'TERM': 'linux', 09:57:42 INFO - 'TMOUT': '86400', 09:57:42 INFO - 'USER': 'cltbld', 09:57:42 INFO - 'XDG_SESSION_COOKIE': '6e558709db315bacd2260379000001b6-1447782471.514496-331499448', 09:57:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:57:42 INFO - '_': '/tools/buildbot/bin/python'} 09:57:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Mozilla-Inbound-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-039', '--webServer', 'localhost'] with output_timeout 3600 09:57:42 INFO - mozversion INFO | application_buildid: 20151117093002 09:57:42 INFO - mozversion INFO | application_changeset: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 09:57:42 INFO - mozversion INFO | application_display_name: Nightly 09:57:42 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:57:42 INFO - mozversion INFO | application_name: Firefox 09:57:42 INFO - mozversion INFO | application_remotingname: firefox 09:57:42 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:57:42 INFO - mozversion INFO | application_vendor: Mozilla 09:57:42 INFO - mozversion INFO | application_version: 45.0a1 09:57:42 INFO - mozversion INFO | platform_buildid: 20151117093002 09:57:42 INFO - mozversion INFO | platform_changeset: 06188c6531b5b06fc9bd2cdcd25eaf5c1b778882 09:57:42 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/mozilla-inbound 09:57:42 INFO - mozversion INFO | platform_version: 45.0a1 09:57:42 INFO - 2015-11-17 09:57:42,889 DEBUG : using testdate: 1447783062 09:57:42 INFO - 2015-11-17 09:57:42,889 DEBUG : actual date: 1447783062 09:57:42 INFO - 2015-11-17 09:57:42,897 INFO : starting webserver on 'localhost:41664' 09:57:42 INFO - 2015-11-17 09:57:42,899 INFO : Starting test suite talos-linux64-ix-039 09:57:42 INFO - 2015-11-17 09:57:42,899 INFO : Starting test dromaeo_css 09:57:42 INFO - 2015-11-17 09:57:42,899 DEBUG : operating with platform_type : linux_ 09:57:42 INFO - 2015-11-17 09:57:42,899 INFO : Initialising browser for dromaeo_css test... 09:57:42 INFO - 2015-11-17 09:57:42,915 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1RZLo/profile http://localhost:41664/getInfo.html 09:57:47 INFO - 2015-11-17 09:57:47,989 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 09:57:47 INFO - 2015-11-17 09:57:47,990 DEBUG : BROWSER_OUTPUT: colorDepth:24 09:57:47 INFO - 2015-11-17 09:57:47,990 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 09:57:47 INFO - 2015-11-17 09:57:47,990 DEBUG : BROWSER_OUTPUT: __metrics 09:57:48 INFO - 2015-11-17 09:57:48,192 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:57:49 INFO - 2015-11-17 09:57:49,385 INFO : Browser initialized. 09:57:49 INFO - 2015-11-17 09:57:49,385 INFO : Running cycle 1/1 for dromaeo_css test... 09:57:49 INFO - 2015-11-17 09:57:49,386 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp_1RZLo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 09:58:01 INFO - 2015-11-17 09:58:01,324 DEBUG : BROWSER_OUTPUT: RSS: Main: 141144064 09:58:01 INFO - 2015-11-17 09:58:01,324 DEBUG : BROWSER_OUTPUT: 09:58:52 INFO - 2015-11-17 09:58:52,838 DEBUG : BROWSER_OUTPUT: 1447783132834 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] 10:01:04 INFO - 2015-11-17 10:01:04,565 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-dojo.html (next: http://localhost:41664/tests/dromaeo/cssquery-ext.html) 10:01:05 INFO - 2015-11-17 10:01:05,674 DEBUG : BROWSER_OUTPUT: RSS: Main: 237944832 10:01:05 INFO - 2015-11-17 10:01:05,675 DEBUG : BROWSER_OUTPUT: 10:04:08 INFO - 2015-11-17 10:04:08,230 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-ext.html (next: http://localhost:41664/tests/dromaeo/cssquery-jquery.html) 10:04:08 INFO - 2015-11-17 10:04:08,803 DEBUG : BROWSER_OUTPUT: RSS: Main: 227237888 10:04:08 INFO - 2015-11-17 10:04:08,804 DEBUG : BROWSER_OUTPUT: 10:07:10 INFO - 2015-11-17 10:07:10,884 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-jquery.html (next: http://localhost:41664/tests/dromaeo/cssquery-mootools.html) 10:07:11 INFO - 2015-11-17 10:07:11,465 DEBUG : BROWSER_OUTPUT: RSS: Main: 215298048 10:07:11 INFO - 2015-11-17 10:07:11,465 DEBUG : BROWSER_OUTPUT: 10:10:13 INFO - 2015-11-17 10:10:13,420 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-mootools.html (next: http://localhost:41664/tests/dromaeo/cssquery-prototype.html) 10:10:14 INFO - 2015-11-17 10:10:14,007 DEBUG : BROWSER_OUTPUT: RSS: Main: 200642560 10:10:14 INFO - 2015-11-17 10:10:14,007 DEBUG : BROWSER_OUTPUT: 10:13:16 INFO - 2015-11-17 10:13:16,766 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-prototype.html (next: http://localhost:41664/tests/dromaeo/cssquery-yui.html) 10:13:17 INFO - 2015-11-17 10:13:17,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 203247616 10:13:17 INFO - 2015-11-17 10:13:17,352 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,728 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/dromaeo/cssquery-yui.html (next: http://localhost:41664/tests/dromaeo/cssquery-dojo.html) 10:16:19 INFO - 2015-11-17 10:16:19,977 DEBUG : BROWSER_OUTPUT: RSS: Main: 246079488 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:16:19 INFO - 2015-11-17 10:16:19,978 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2669.159214847323;2755.063278485316;2776.944461110778;2777.2223777342324;2779.4163225722596;4568.154891345103;4739.218029025206;4746.382970213872;4766.213574760165;4807.951920480794;4693.5306469353045;4748.264019077049;4758.50035746246;4776.785044672989;4831.975840120795;4336.176126535964;4410.911781764363;4418.293073108303;4453.910921781562;4509.368688383613;4441.866743997685;4449.332600109977;4493.033997690496;4555.5899969002785;4586.7018643788215;4199.328107502785;4322.805473753689;4512.187806194884;4557.179707652621;4559.589636932676;4315.697901146889;4417.933730994006;4431.7784110794655;4437.933430998538;4457.64338852891;4403.185410699031;4440.4893437254805;4441;4452.287633978548;4493.4832494263255;4520.367148599199;4649.232876575361;4663.953360466419;4771.23660214364;4796.328514008042;5016.247562865563;5039.622028347889;5051.368578927634;5060.797568097309;5092.592592592584;5001.449840517576;5137.51193636604;5146.794128234867;5152.278680984665;5192.3249977503065;4555.06621142665;4707.223308154184;4720.598749106296;4745.335653008616;4768.594669453136;5167.509086636764;5260.13207820713;5278.261043453919;5283.498067683564;5319.281896943863;5092.26162206478;5102.3877134743325;5105.795768169231;5108.6168537359845;5114.565261952701;4888.780004899788;5011;5011.4236862761245;5181.4300426953005;5223.242629818655;4862.610991120702;4945.950540494621;4952.752362381866;4953.504649535018;4991.425986011583;5036.722980236123;5038.294638750578;5042.974785126051;5050.974745126325;5083.847484575469;3782.167923056978;3893.143508428141;3894.9610503895165;3906.3554513505524;3942.329803933338;3412.5563676722363;3515.1563624730393;3538.327717733622;3561.28774245152;3569.3575156471566;4423.51341352451;4424.7123936944;4435.090806384684;4435.090806384684;4472.060867217856;4955.108080545537;5096.668716533413;5185.325907631984;5186.273921650972;5224.693826543365;4332.653387728974;4343.435353404037;4397.978010109929;4417.2269852775635;4445.488768791565;4576.107659006462;4577.176108300538;4578.35902973584;4587.220172570671;4611.400517932647;4667.416572928384;4775.904481910273;4862.708237505761;4943.233798761198;4986.825461108844;4997.2504124380175;5054.7978080876355;5072.391313042459;5114.028334616411;5139.254808052886;4865.854024379274;4868.41579010521;4870.80516779339;4881.121398148225;4905.166121759381;4838.7822547986125;4955.628327875496;5064.594832413324;5069.062223488666;5102.566281866083;5083.5678967288195;5095.87260318495;5209.635325527177;5211.114110601131;5223.242629818579;5067.493250674903;5077.644564880571;5084.923726144185;5088.771005304696;5140.280360749423;4772.284157376422;4904.509549045067;5062.898742025065;5072.492750724898;5074.670146440617;4779.784909679142;4853.684510506806;4879.268109783561;4888.90222195547;4904.092742842586;5009.173486374853;5020.874478138076;5022.372203474566;5029.59763218949;5036.496350364934;4706.411698537683;4920.753962301942;4926.556609905126;4927.728974906271;4956.578690811321 10:16:19 INFO - 2015-11-17 10:16:19,979 DEBUG : BROWSER_OUTPUT: |1;ext.html;544.3114460207838;560.5991715923116;570.7117905457743;578.910268908319;592.4756590417479;27774.166774996756;36360.45459318109;36780;36809.44785828215;36815.44776828343;39508.80245598775;40250.79874600623;40273.597264027354;40280.79859600705;40331.79834100825;6915.308469153095;7044.22513523512;7664.92335076649;7908.841823163533;7911.8417631647335;9735.56189971453;9883.209343252522;9884.308098433112;9913.405195688245;9997.400155990628;9883.406995580252;10006.299559030871;10008.449535275557;10009.649662261785;10018.39889606626;6997.1603407591165;7243.311885370881;7259.165196002475;9831;9925.205983521373;9680.854787178198;9816.705498834976;9824.950875245579;9828.606855725762;9833.459159746211;36446.45330320048;36714.265714685556;36762.44856327157;36861.631383686086;36875.446868297;2494.787943024845;2692.25962860215;2700.9729902701115;2711.173092206876;2857.8999735009174;27570;27642.308942276602;28041.439171216665;28056.859715701292;28118.156455306373;2955.8126986030184;2980.2251414632133;2991.476491613959;3033.924151896198;3056.9235769105726;230709;231107.9999999983;231263;231373;231867;47879.76060119677;48738.5126148734;51845.74077129666;52171.73914130405;52547.73726131345;49152.75423622859;49209.507904920494;49393.50606493961;49491.50508494941;49539.752301238266;12491.188072775241;12555.748885022249;12682.365881705879;12693.238405695687;12695.365231738377;9632;9635.951820240994;9643.951780241054;9663.082007209305;9731.318807683394;17402.47792566225;17547.47357579275;17673.646527069388;17685.911570442066;17723.582113430894;7224.747133850396;7430.368418684472;7448.9627551861895;7519.323260906544;7536.660850261751;785.7564155111934;856.6188046319453;891.7592250092569;1016.598443614768;1057.5981127171626;25367.746322536907;25918.74081259201;26405.207843764718;26981.595276070482;27020.32449188786;889.644142343068;908.895477020138;923.1922068190333;932.5756780664781;1039.9064084232455;12164.33096179701;12432.564860229848;12449.190802597803;12465.875341246472;12512;253601;261139;261468;261918;262048;43823.780881095394;44081.338779918326;44210.77894610506;44233.33649995253;44272.11455770931;1167.0721776187952;1174.307158776309;1174.3306315400312;1175.353555544447;1184.573553520749;19652.50868728236;25664.486710266065;27275.318117046438;27702.307442314104;27815.860920695268;39360.40959385669;39748.80125599354;39782.60217397789;39788.20423591454;39858;221570;223093;223412;223624;224359;23411.414714632272;26098.478030438906;27078.458430831666;27817;27988.44023119567;32535.18662033468;32703.34593308168;37129.6287037137;37896.621033789306;38235;31126.22184445407;31359.529607055458;31872;32326;32651.510227346134;30831.38337233198;31353;31709.048728538182;31797;31823.522647160775;31775.523367149974;31822.681773181972;31869.840650797527;31920.201994950312;34701.47947780836;32458.83770581132;34989.650103499655;35542.28915421729;36019;36319;27959.720402795712;29099;30678.846605766827;30729.574360943083;30848.537271941386 10:16:19 INFO - 2015-11-17 10:16:19,981 DEBUG : BROWSER_OUTPUT: |2;jquery.html;338.51085181912134;338.839051450561;340.3329474230508;341.8786330852547;343.02922728677845;11920.7615847683;12316.568920087799;14703.926480367596;14775.778363324545;16545.834541654578;10958.671239862797;11266.267692599975;11290.040346570551;14855.480058197938;15339.309731062101;4145.606167414091;4179.498460184782;4264.786760661955;4267.210566045276;4276.807543660543;3179.364127174563;3260.755443341747;4731.78706958186;4846.466888642247;4848.854534363974;4768.094062128184;4783.449903261135;4792.616590672737;4794.113089078514;4797.11253418117;4676;4779.450363208223;4780.760961951889;4825.20384136617;4831.130396528606;4150.149219410014;4152.854650087233;4159.376093585956;4159.9376009359885;4160.313548264533;12875.871241287561;13090.607281781466;13182.802257966137;13211.801822972662;13221.669458263525;1581.5966928433177;1586.420956350935;1699.209867411647;1749.3527394863981;1759.0589034866284;9396.107369799858;9504.572294246775;9507.90492095077;9790.755231119208;9814.362066465728;1593.6573636668056;1595.505393328072;1634.983650163495;1675.7821483207106;1703.5059832648517;53738.46261537373;53792;54386;54447;55241.72379138119;6606.10817539626;6730.394264516217;6732.360425759545;6740.797776066725;6767.695453704497;7979.760607181794;7997.160298168725;8005.719799806979;8009.199080091944;8009.23912228349;4807.759612019455;4866.78099485524;4951.331570238044;4984.551390374883;4996.725180115056;4864.683795553277;4904.509549045067;4930.482299358516;4932.8520144395725;4937.925931111036;3060.127863558875;3099.1942095055447;3125.4374212641487;3127.62468503781;3130.201798541357;1069.540097757956;1076.4294923690456;1101.911847052234;1109.8358201507094;1153.1236260442124;417.0928231097351;433.462506491954;444.3334997503744;447.0187937477271;488.2310361181083;10471.581136754445;10885.891141088488;10901.236913415985;10910.181736369805;10935.56257749697;415.46820070310054;427.3098945203474;465.59958435745233;469.92951057341674;472.5581581221569;5876.382979787147;5959.225300710967;6036.486898613667;6040.093985902062;6065.969670151621;444250;447981;456785;464398;465622;63652;65164.67417662881;65278.70386035438;65978.67010665013;66242;515.7112017270341;515.7215103843957;520.4301290087349;520.6147450886392;521.3326941514867;10202.795944081225;10208.489575521342;10271.94864025675;10364.740881478023;10418.166546676097;31221.375572488876;31625;31741.20646983844;31942.840285798422;32203.51694724628;41642;41964.79017605015;43183;43698.563014370724;44158;6161.784337548164;6431.421172094534;6507.609543427409;6509.902351464826;6514.609123452608;11226.887731122912;11355.54577816878;11432.94283528577;11491.827622585835;11541;8304.460210086325;8587.570621469027;9437.433753974783;9457.38526995743;9659.806803864023;8692.91307086921;8859.24696400813;9703;9818.459984700625;10028.64899728506;9401.717948461557;9430.575624096795;9898.505074746377;9931.404115753077;9937.801243974935;11717.76564468723;11740.471678774305;12749.17130386522;12940;13496.32518374097;13933.164010159422;14605.85394146045;15099.6780708244;15354.155521446428;15506.379744810081 10:16:19 INFO - 2015-11-17 10:16:19,984 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1350.655582826379;1379.6688794689278;1419.6379923119607;1490.426185918421;1645.794275715535;6002.279726432828;6578.375054369833;6920.723171073158;6924.861502769942;6934.098567186259;6780.49146314026;6889.827754306132;6894.345037221468;6899.448044156468;6899.827504312395;1735.8871673341193;1765.9028753418556;1767.4874286456911;2044.5297581556215;2059.5160137367707;1762.3391228289393;1771;2034.7660019097846;2069.937901862939;2077.2937201351538;2028.878267303959;2034.4608678700156;2040.2043203150708;2041.2753472517265;2042.428120126367;1958.4418440744391;2001.7497812773404;2005.3081686818098;2006.3579654510563;2008.7087372331002;2028.2698228637678;2048.795120487954;2072.253988564116;2075.2529089527757;2075.3670130610158;6888.276730943229;6974.232834388264;6976.232614412411;6986.126734158231;6990.895136572904;4127.938080928789;4176.227397931392;4201.70588058836;4217.641500472463;4220.029393239542;2616.6859976802716;2664;2687.7446642568925;2715.117586784303;2718.347596576827;836.7615229659518;842.2630198576246;845.1168528887328;876.9123087691244;883.779055236191;9247.491387973727;9257.907420925772;9269.304802139866;9279.39683920543;9333.06669333068;3848.634379733921;3871.05159235989;3936.606339366098;3987.720859539804;4009.959900401017;8120.269175774209;8125.02499700028;8125.187481251945;8129.268365846984;8168.06067302256;4159.729617574848;4173.373993900878;4174.540800511942;4175.415441838145;4181.874543763692;3736.9626303736613;3744.2137151198554;3754.2303827715255;3756.1360886996144;3758.4550240215563;3446;3448.9310213796084;3464.7055000325254;3473.7568370213844;3492.738044646611;946.0444950599943;949.5774380400655;1129.824877144044;1144.2562334482486;1151.8272259161192;853.0744142605218;858.6350800909588;859.5616235719828;911.5852287209303;1036.3471013261596;6220.377962203744;6296.590721603081;6330.620162790247;6330.715117819709;6335.746570137235;975.1223898491414;989.4805227255748;1005.9647912323034;1016.1667432705111;1020.4489575629077;4744.074905393415;4861.392325959255;4877.365942427462;4882.9257563336005;4888.486708895514;8296.8340633187;8418.200270974248;8437.535935523605;8474.491530508067;8487.660493580188;8077.959610202029;8417.70538031166;8423.873641895376;8431.241188293083;8437.114103019094;6621.437177839841;6676.666166691646;6709.664516774142;6716.126903502513;6732.596044237263;6046.425589568984;6067.089936509559;6160.691965401622;6209.720562574605;6212.502999760099;7345.375643070399;7517.436192285491;7518.173000969779;7568.735094271674;7608.505447145918;7557.206493318123;7637.770866874002;7644.847103058019;7749.7675069748;7761.573113478587;5994.400559943971;6101.237345331833;6107.9083813741945;6116.17431646722;6116.908246376219;5705.486506214461;6262.812115636538;6317.147185129948;6320.367963203643;6322.525810564318;5348.759305831325;5707.0583353747825;6108;6120.173776540289;6229.56393052482;6214.689265536796;6260.436560709558;6275.435210831047;6340.461060809883;6384.233891932998;6254.343293954069;6280.403361680633;6281.089242059785;6288.5283603728985;6288.773689130576;5725.227094342377;5750.079987202028;5751.338596061507;5753.079507278815;5758.539316854725;5836.620619659879;5855.970720146372;5899.793507227227;5914.290285165807;5916.023856063874 10:16:19 INFO - 2015-11-17 10:16:19,985 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.72879594752567;315.0705419013908;316.9334439767649;321.59318462145393;322.8579425052978;5307.840764777058;5530.05988981873;5551.944480555193;5579.832605021851;5583.972080139593;5369.5972802039805;5430.75561599728;5439.5376393006545;5449.427810079934;5454.645448045874;3970.920581588381;4045.0898547826796;4091.2022155679656;4217.662586993033;4220.53574106848;4182.89153374356;4191.55988621195;4197.454330936989;4209.557996410379;4220.915581688364;4162.646175075122;4162.771047592381;4167.249895018896;4170.291050521419;4171.311733563958;3924.666403355718;3995.3407687731487;4050.858219962287;4168.333066709312;4173.520045194811;3645.908852278688;3649.069487280753;3650.7079433645245;3652.506911566931;3653.5250417445563;5199.974000129975;5220.686758794446;5223.2165175223645;5224.555912747421;5225.712585807779;4819.975900120512;4828.879278018043;4832.589229915427;4833.347498087748;4833.984863178736;5567.248421463091;5724.313082430093;5734.254546908917;5757.769689212427;5786.987277226469;4055.1889622075705;4068.044009657728;4071.1247081877536;4072.572379900127;4119.155573107506;5972.9701351493395;6051.304100028509;6056.182415373913;6061.212042434499;6063.393660633989;4227.281362168439;4228.6617070634275;4231.830726770956;4232.217039847638;4232.978835105805;4202.894927626772;4294.7852607369505;4299.1831552005015;4303.763293018851;4312.835534405693;4845.878853028703;4860;4861.489543597942;4862.343583616237;4864.562189402971;5737.8565535861935;5748.741306641127;5749.281339832521;5749.310082790092;5751.022326204472;1507.9321430535651;1531.9693606127814;1532.3564103076735;1533.7776022476678;1533.9846601534066;1043.9895601043893;1048.4076496779448;1055.757175849559;1071.0414179309475;1080.9459527023616;5043.646944713908;5049.141645920129;5051.545360917535;5054.696718196847;5055.292259083732;5964.761409543657;5969.104634304889;5969.164316995624;5969.253843269591;5969.880602387928;5036.143855544567;5055.620828437882;5056;5057.14028615129;5064.392272927273;2993.5060714981782;3101.1936896407096;3198.200449887528;3213.951790723141;3259.869605215812;5665;5673.8297851064535;5675.489205971482;5686.687232202268;5690.5447564194765;6183.196184495987;6183.227096612924;6187.628742275388;6189.659568723763;6198.473129784019;5552.472515111058;5668.093105103246;5670.971645141748;5678.716064196857;5680.034394153004;5960.672163031075;5990.7304171311525;5993.730282137227;6008.309044459943;6011.398860114128;5825.883482330414;5830.941690583039;5832.037713777349;5838.737256823369;5839.737211825393;5660.575456840836;5663.603547751618;5667.971660141673;5668.319801623831;5673.290838645169;4028;4149.294619914682;4170.249355116108;4269.594388533084;4276.48682158143;5972.432618901197;5972.820815375546;5972.850678733066;5974.970125149346;5976.402359763989;5748;5751.511121554715;5754.856128596819;5758.1650660654805;5760.481556659921;5630.690312032713;5736.741846616996;5749.856253593526;5750.942490575041;5752.654840709571;5604.439556044526;5611.523020543136;5623.2408624835125;5629.915551266816;5630.831075067755;5786.537077033743;5790.913136303043;5792.189093526826;5792.21805056312;5792.507636850914;5411.918821217606;5591.245181900554;5617.213590097308;5621.325440947113;5625.46558076982 10:16:19 INFO - 2015-11-17 10:16:19,987 DEBUG : BROWSER_OUTPUT: |5;yui.html;672.7981605518345;694.1773997812593;694.9548279361844;711.7722328854766;727.4507746651277;10865.293755905861;11129.610463633775;11144.275622084559;11147.108231341494;11152.163587730913;11008.944955275232;11051.336919784819;11074.944625276883;11089.05743011843;11117.5552977881;758.4652819762055;774.2064384006383;774.7365895595497;774.9341305988969;775.2751177648917;602.0367412140562;607.6870411737937;763.2177018555969;778.3734094054313;782.5343920367372;819.3649921310972;820.7660816667251;827.2182787266036;827.5407149032285;827.6358402302998;618.7246675229525;817.1256755271861;818.1000899011041;818.4966245758875;818.8157664525494;462.76630301697764;583.422411812307;593.9316978547479;594.191899017336;594.509529638046;11096.944515277453;11144.164187685956;11148.554057837677;11155.832662510069;11163.106951443864;10073.194144468425;10182.439965801877;10209;10219.437930913797;10803.027727504485;8429.32565394767;8527.829443411098;8580.18488243622;8630.395872288942;8683.956580217058;3096.9380612387627;3162.5256211568217;3189.282411457427;3189.9681003190135;3197.2006998250436;39493.60506394928;39643;39753;39845.40231896495;39948.20103597912;7828.334591559781;7843.333316668033;7871.134175240719;7921.287084162453;8001.759947201594;14406.711865762625;14442.927785361217;14458.20479873596;14470.855291446951;14474.059186152866;5679.091345384719;5744.396838331999;5771.163181338682;5792.739326730307;5950.256217972754;3380.1042723678247;3430.811305378178;3473.513708080871;3482.6169121396624;3509.298140371936;2351.494428697804;2385.4990452004927;2490.4396510784927;2542.1992072497105;2544.5928651415684;439.1086095226695;439.90981848720935;445.72365133616717;446.43303005183884;447.40941956617604;378.26238834272726;382.6776558768714;394.5699187885219;410.5832579931372;416.28814726816876;6283.2460104787715;6310.652914089677;6395.776147834897;6400.583962042452;6466.159399278158;330.1021222275407;402.90531725044593;453.53739186030725;507.8958813443235;509.0734862550123;3085.2414123949584;3096.3342881280632;3107.300857307133;3166.224275052627;3181.618205815317;46437.30344044842;48515.51484485181;48768.26847597289;48939;51771.48228517742;45582.31626525605;45646.771766140955;45775;46389.30416043762;47588.5241147591;40922.59077409188;41624.1675166495;41865.58134418678;42570.14859702789;42745.57254427478;6304.6129851432615;6555.868882622416;6778.627175505198;6781.728730850711;6847.965760171167;31584.526232106997;31729.365412692077;32305.35389292154;32415.35169296648;32768.836155819066;36216.275674485834;36327.27345453129;36337;39768.801155994035;40181.397279040255;6663.8667226654225;6733.6296503692765;6780.72877084911;6784.59292442455;6956.756513522205;9549.140577348073;9559.808803824024;9568.947415784398;9605.087516686182;9705.951470242604;8176;8201.097879233399;8216.507009579444;8221.342292616457;8364.874526882224;8317.168283171635;8540.274076703301;8710.433821801562;8775.56122193875;8786.297096232414;7502.587357695161;8440.409171357946;8476;8613.741587752378;8697.95651021741;7444.888326675213;7531.133919599316;7992.840143196987;8028.638711258124;8220.342372610057;7106.324899134574;7180.748673796392;7272.454565907472;7395.371393431404;7579.204183560867 10:16:19 INFO - 2015-11-17 10:16:19,987 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:16:19 INFO - 2015-11-17 10:16:19,987 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:16:19 INFO - 2015-11-17 10:16:19,987 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,922 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: __startTimestamp1447784179976__endTimestamp 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: Number of tests: 6 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,988 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4702.89 Median:4862.61 stddev:515.33 (10.6%) stddev-sans-first:491.60 10:16:19 INFO - 2015-11-17 10:16:19,990 DEBUG : BROWSER_OUTPUT: Values: 2669.2 2755.1 2776.9 2777.2 2779.4 4568.2 4739.2 4746.4 4766.2 4808.0 4693.5 4748.3 4758.5 4776.8 4832.0 4336.2 4410.9 4418.3 4453.9 4509.4 4441.9 4449.3 4493.0 4555.6 4586.7 4199.3 4322.8 4512.2 4557.2 4559.6 4315.7 4417.9 4431.8 4437.9 4457.6 4403.2 4440.5 4441.0 4452.3 4493.5 4520.4 4649.2 4664.0 4771.2 4796.3 5016.2 5039.6 5051.4 5060.8 5092.6 5001.4 5137.5 5146.8 5152.3 5192.3 4555.1 4707.2 4720.6 4745.3 4768.6 5167.5 5260.1 5278.3 5283.5 5319.3 5092.3 5102.4 5105.8 5108.6 5114.6 4888.8 5011.0 5011.4 5181.4 5223.2 4862.6 4946.0 4952.8 4953.5 4991.4 5036.7 5038.3 5043.0 5051.0 5083.8 3782.2 3893.1 3895.0 3906.4 3942.3 3412.6 3515.2 3538.3 3561.3 3569.4 4423.5 4424.7 4435.1 4435.1 4472.1 4955.1 5096.7 5185.3 5186.3 5224.7 4332.7 4343.4 4398.0 4417.2 4445.5 4576.1 4577.2 4578.4 4587.2 4611.4 4667.4 4775.9 4862.7 4943.2 4986.8 4997.3 5054.8 5072.4 5114.0 5139.3 4865.9 4868.4 4870.8 4881.1 4905.2 4838.8 4955.6 5064.6 5069.1 5102.6 5083.6 5095.9 5209.6 5211.1 5223.2 5067.5 5077.6 5084.9 5088.8 5140.3 4772.3 4904.5 5062.9 5072.5 5074.7 4779.8 4853.7 4879.3 4888.9 4904.1 5009.2 5020.9 5022.4 5029.6 5036.5 4706.4 4920.8 4926.6 4927.7 4956.6 10:16:19 INFO - 2015-11-17 10:16:19,990 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,990 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39646.69 Median:32392.42 stddev:61993.59 (191.4%) stddev-sans-first:62097.97 10:16:19 INFO - 2015-11-17 10:16:19,991 DEBUG : BROWSER_OUTPUT: Values: 544.3 560.6 570.7 578.9 592.5 27774.2 36360.5 36780.0 36809.4 36815.4 39508.8 40250.8 40273.6 40280.8 40331.8 6915.3 7044.2 7664.9 7908.8 7911.8 9735.6 9883.2 9884.3 9913.4 9997.4 9883.4 10006.3 10008.4 10009.6 10018.4 6997.2 7243.3 7259.2 9831.0 9925.2 9680.9 9816.7 9825.0 9828.6 9833.5 36446.5 36714.3 36762.4 36861.6 36875.4 2494.8 2692.3 2701.0 2711.2 2857.9 27570.0 27642.3 28041.4 28056.9 28118.2 2955.8 2980.2 2991.5 3033.9 3056.9 230709.0 231108.0 231263.0 231373.0 231867.0 47879.8 48738.5 51845.7 52171.7 52547.7 49152.8 49209.5 49393.5 49491.5 49539.8 12491.2 12555.7 12682.4 12693.2 12695.4 9632.0 9636.0 9644.0 9663.1 9731.3 17402.5 17547.5 17673.6 17685.9 17723.6 7224.7 7430.4 7449.0 7519.3 7536.7 785.8 856.6 891.8 1016.6 1057.6 25367.7 25918.7 26405.2 26981.6 27020.3 889.6 908.9 923.2 932.6 1039.9 12164.3 12432.6 12449.2 12465.9 12512.0 253601.0 261139.0 261468.0 261918.0 262048.0 43823.8 44081.3 44210.8 44233.3 44272.1 1167.1 1174.3 1174.3 1175.4 1184.6 19652.5 25664.5 27275.3 27702.3 27815.9 39360.4 39748.8 39782.6 39788.2 39858.0 221570.0 223093.0 223412.0 223624.0 224359.0 23411.4 26098.5 27078.5 27817.0 27988.4 32535.2 32703.3 37129.6 37896.6 38235.0 31126.2 31359.5 31872.0 32326.0 32651.5 30831.4 31353.0 31709.0 31797.0 31823.5 31775.5 31822.7 31869.8 31920.2 34701.5 32458.8 34989.7 35542.3 36019.0 36319.0 27959.7 29099.0 30678.8 30729.6 30848.5 10:16:19 INFO - 2015-11-17 10:16:19,991 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23781.66 Median:43928.28 stddev:74653.23 (169.9%) stddev-sans-first:74841.90 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: Values: 338.5 338.8 340.3 341.9 343.0 11920.8 12316.6 14703.9 14775.8 16545.8 10958.7 11266.3 11290.0 14855.5 15339.3 4145.6 4179.5 4264.8 4267.2 4276.8 3179.4 3260.8 4731.8 4846.5 4848.9 4768.1 4783.4 4792.6 4794.1 4797.1 4676.0 4779.5 4780.8 4825.2 4831.1 4150.1 4152.9 4159.4 4159.9 4160.3 12875.9 13090.6 13182.8 13211.8 13221.7 1581.6 1586.4 1699.2 1749.4 1759.1 9396.1 9504.6 9507.9 9790.8 9814.4 1593.7 1595.5 1635.0 1675.8 1703.5 53738.5 53792.0 54386.0 54447.0 55241.7 6606.1 6730.4 6732.4 6740.8 6767.7 7979.8 7997.2 8005.7 8009.2 8009.2 4807.8 4866.8 4951.3 4984.6 4996.7 4864.7 4904.5 4930.5 4932.9 4937.9 3060.1 3099.2 3125.4 3127.6 3130.2 1069.5 1076.4 1101.9 1109.8 1153.1 417.1 433.5 444.3 447.0 488.2 10471.6 10885.9 10901.2 10910.2 10935.6 415.5 427.3 465.6 469.9 472.6 5876.4 5959.2 6036.5 6040.1 6066.0 444250.0 447981.0 456785.0 464398.0 465622.0 63652.0 65164.7 65278.7 65978.7 66242.0 515.7 515.7 520.4 520.6 521.3 10202.8 10208.5 10271.9 10364.7 10418.2 31221.4 31625.0 31741.2 31942.8 32203.5 41642.0 41964.8 43183.0 43698.6 44158.0 6161.8 6431.4 6507.6 6509.9 6514.6 11226.9 11355.5 11432.9 11491.8 11541.0 8304.5 8587.6 9437.4 9457.4 9659.8 8692.9 8859.2 9703.0 9818.5 10028.6 9401.7 9430.6 9898.5 9931.4 9937.8 11717.8 11740.5 12749.2 12940.0 13496.3 13933.2 14605.9 15099.7 15354.2 15506.4 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4823.07 Median:6107.95 stddev:2497.23 (40.9%) stddev-sans-first:2490.60 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: Values: 1350.7 1379.7 1419.6 1490.4 1645.8 6002.3 6578.4 6920.7 6924.9 6934.1 6780.5 6889.8 6894.3 6899.4 6899.8 1735.9 1765.9 1767.5 2044.5 2059.5 1762.3 1771.0 2034.8 2069.9 2077.3 2028.9 2034.5 2040.2 2041.3 2042.4 1958.4 2001.7 2005.3 2006.4 2008.7 2028.3 2048.8 2072.3 2075.3 2075.4 6888.3 6974.2 6976.2 6986.1 6990.9 4127.9 4176.2 4201.7 4217.6 4220.0 2616.7 2664.0 2687.7 2715.1 2718.3 836.8 842.3 845.1 876.9 883.8 9247.5 9257.9 9269.3 9279.4 9333.1 3848.6 3871.1 3936.6 3987.7 4010.0 8120.3 8125.0 8125.2 8129.3 8168.1 4159.7 4173.4 4174.5 4175.4 4181.9 3737.0 3744.2 3754.2 3756.1 3758.5 3446.0 3448.9 3464.7 3473.8 3492.7 946.0 949.6 1129.8 1144.3 1151.8 853.1 858.6 859.6 911.6 1036.3 6220.4 6296.6 6330.6 6330.7 6335.7 975.1 989.5 1006.0 1016.2 1020.4 4744.1 4861.4 4877.4 4882.9 4888.5 8296.8 8418.2 8437.5 8474.5 8487.7 8078.0 8417.7 8423.9 8431.2 8437.1 6621.4 6676.7 6709.7 6716.1 6732.6 6046.4 6067.1 6160.7 6209.7 6212.5 7345.4 7517.4 7518.2 7568.7 7608.5 7557.2 7637.8 7644.8 7749.8 7761.6 5994.4 6101.2 6107.9 6116.2 6116.9 5705.5 6262.8 6317.1 6320.4 6322.5 5348.8 5707.1 6108.0 6120.2 6229.6 6214.7 6260.4 6275.4 6340.5 6384.2 6254.3 6280.4 6281.1 6288.5 6288.8 5725.2 5750.1 5751.3 5753.1 5758.5 5836.6 5856.0 5899.8 5914.3 5916.0 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,992 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4774.64 Median:5338.72 stddev:1398.85 (26.2%) stddev-sans-first:1362.07 10:16:19 INFO - 2015-11-17 10:16:19,993 DEBUG : BROWSER_OUTPUT: Values: 311.7 315.1 316.9 321.6 322.9 5307.8 5530.1 5551.9 5579.8 5584.0 5369.6 5430.8 5439.5 5449.4 5454.6 3970.9 4045.1 4091.2 4217.7 4220.5 4182.9 4191.6 4197.5 4209.6 4220.9 4162.6 4162.8 4167.2 4170.3 4171.3 3924.7 3995.3 4050.9 4168.3 4173.5 3645.9 3649.1 3650.7 3652.5 3653.5 5200.0 5220.7 5223.2 5224.6 5225.7 4820.0 4828.9 4832.6 4833.3 4834.0 5567.2 5724.3 5734.3 5757.8 5787.0 4055.2 4068.0 4071.1 4072.6 4119.2 5973.0 6051.3 6056.2 6061.2 6063.4 4227.3 4228.7 4231.8 4232.2 4233.0 4202.9 4294.8 4299.2 4303.8 4312.8 4845.9 4860.0 4861.5 4862.3 4864.6 5737.9 5748.7 5749.3 5749.3 5751.0 1507.9 1532.0 1532.4 1533.8 1534.0 1044.0 1048.4 1055.8 1071.0 1080.9 5043.6 5049.1 5051.5 5054.7 5055.3 5964.8 5969.1 5969.2 5969.3 5969.9 5036.1 5055.6 5056.0 5057.1 5064.4 2993.5 3101.2 3198.2 3214.0 3259.9 5665.0 5673.8 5675.5 5686.7 5690.5 6183.2 6183.2 6187.6 6189.7 6198.5 5552.5 5668.1 5671.0 5678.7 5680.0 5960.7 5990.7 5993.7 6008.3 6011.4 5825.9 5830.9 5832.0 5838.7 5839.7 5660.6 5663.6 5668.0 5668.3 5673.3 4028.0 4149.3 4170.2 4269.6 4276.5 5972.4 5972.8 5972.9 5975.0 5976.4 5748.0 5751.5 5754.9 5758.2 5760.5 5630.7 5736.7 5749.9 5750.9 5752.7 5604.4 5611.5 5623.2 5629.9 5630.8 5786.5 5790.9 5792.2 5792.2 5792.5 5411.9 5591.2 5617.2 5621.3 5625.5 10:16:19 INFO - 2015-11-17 10:16:19,993 DEBUG : BROWSER_OUTPUT: 10:16:19 INFO - 2015-11-17 10:16:19,994 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11516.51 Median:28725.29 stddev:13984.53 (48.7%) stddev-sans-first:14000.05 10:16:19 INFO - 2015-11-17 10:16:19,994 DEBUG : BROWSER_OUTPUT: Values: 672.8 694.2 695.0 711.8 727.5 10865.3 11129.6 11144.3 11147.1 11152.2 11008.9 11051.3 11074.9 11089.1 11117.6 758.5 774.2 774.7 774.9 775.3 602.0 607.7 763.2 778.4 782.5 819.4 820.8 827.2 827.5 827.6 618.7 817.1 818.1 818.5 818.8 462.8 583.4 593.9 594.2 594.5 11096.9 11144.2 11148.6 11155.8 11163.1 10073.2 10182.4 10209.0 10219.4 10803.0 8429.3 8527.8 8580.2 8630.4 8684.0 3096.9 3162.5 3189.3 3190.0 3197.2 39493.6 39643.0 39753.0 39845.4 39948.2 7828.3 7843.3 7871.1 7921.3 8001.8 14406.7 14442.9 14458.2 14470.9 14474.1 5679.1 5744.4 5771.2 5792.7 5950.3 3380.1 3430.8 3473.5 3482.6 3509.3 2351.5 2385.5 2490.4 2542.2 2544.6 439.1 439.9 445.7 446.4 447.4 378.3 382.7 394.6 410.6 416.3 6283.2 6310.7 6395.8 6400.6 6466.2 330.1 402.9 453.5 507.9 509.1 3085.2 3096.3 3107.3 3166.2 3181.6 46437.3 48515.5 48768.3 48939.0 51771.5 45582.3 45646.8 45775.0 46389.3 47588.5 40922.6 41624.2 41865.6 42570.1 42745.6 6304.6 6555.9 6778.6 6781.7 6848.0 31584.5 31729.4 32305.4 32415.4 32768.8 36216.3 36327.3 36337.0 39768.8 40181.4 6663.9 6733.6 6780.7 6784.6 6956.8 9549.1 9559.8 9568.9 9605.1 9706.0 8176.0 8201.1 8216.5 8221.3 8364.9 8317.2 8540.3 8710.4 8775.6 8786.3 7502.6 8440.4 8476.0 8613.7 8698.0 7444.9 7531.1 7992.8 8028.6 8220.3 7106.3 7180.7 7272.5 7395.4 7579.2 10:16:19 INFO - 2015-11-17 10:16:19,994 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:16:19 INFO - 2015-11-17 10:16:19,994 DEBUG : BROWSER_OUTPUT: 10:16:20 INFO - 2015-11-17 10:16:20,715 INFO : Browser exited with error code: 0 10:16:20 INFO - 2015-11-17 10:16:20,738 INFO : Completed test dromaeo_css (00:18:37) 10:16:20 INFO - 2015-11-17 10:16:20,738 INFO : Starting test kraken 10:16:20 INFO - 2015-11-17 10:16:20,738 DEBUG : operating with platform_type : linux_ 10:16:20 INFO - 2015-11-17 10:16:20,739 INFO : Initialising browser for kraken test... 10:16:20 INFO - 2015-11-17 10:16:20,745 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlK0tc/profile http://localhost:41664/getInfo.html 10:16:24 INFO - 2015-11-17 10:16:24,846 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:16:24 INFO - 2015-11-17 10:16:24,846 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:16:24 INFO - 2015-11-17 10:16:24,846 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:16:24 INFO - 2015-11-17 10:16:24,846 DEBUG : BROWSER_OUTPUT: __metrics 10:16:25 INFO - 2015-11-17 10:16:25,030 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:16:26 INFO - 2015-11-17 10:16:26,164 INFO : Browser initialized. 10:16:26 INFO - 2015-11-17 10:16:26,165 INFO : Running cycle 1/1 for kraken test... 10:16:26 INFO - 2015-11-17 10:16:26,165 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpjlK0tc/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:16:38 INFO - 2015-11-17 10:16:38,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 141930496 10:16:38 INFO - 2015-11-17 10:16:38,118 DEBUG : BROWSER_OUTPUT: 10:16:40 INFO - 2015-11-17 10:16:40,697 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-beat-detection) 10:16:41 INFO - 2015-11-17 10:16:41,283 DEBUG : BROWSER_OUTPUT: RSS: Main: 179929088 10:16:41 INFO - 2015-11-17 10:16:41,283 DEBUG : BROWSER_OUTPUT: 10:16:44 INFO - 2015-11-17 10:16:44,029 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-dft) 10:16:44 INFO - 2015-11-17 10:16:44,602 DEBUG : BROWSER_OUTPUT: RSS: Main: 167514112 10:16:44 INFO - 2015-11-17 10:16:44,602 DEBUG : BROWSER_OUTPUT: 10:16:47 INFO - 2015-11-17 10:16:47,637 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-fft) 10:16:48 INFO - 2015-11-17 10:16:48,198 DEBUG : BROWSER_OUTPUT: RSS: Main: 151498752 10:16:48 INFO - 2015-11-17 10:16:48,198 DEBUG : BROWSER_OUTPUT: 10:16:50 INFO - 2015-11-17 10:16:50,251 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:41664/tests/kraken/driver.html?testName=audio-oscillator) 10:16:50 INFO - 2015-11-17 10:16:50,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 154599424 10:16:50 INFO - 2015-11-17 10:16:50,820 DEBUG : BROWSER_OUTPUT: 10:16:53 INFO - 2015-11-17 10:16:53,005 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:16:53 INFO - 2015-11-17 10:16:53,572 DEBUG : BROWSER_OUTPUT: RSS: Main: 154628096 10:16:53 INFO - 2015-11-17 10:16:53,572 DEBUG : BROWSER_OUTPUT: 10:16:56 INFO - 2015-11-17 10:16:56,593 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-darkroom) 10:16:57 INFO - 2015-11-17 10:16:57,166 DEBUG : BROWSER_OUTPUT: RSS: Main: 154947584 10:16:57 INFO - 2015-11-17 10:16:57,166 DEBUG : BROWSER_OUTPUT: 10:17:00 INFO - 2015-11-17 10:17:00,621 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:41664/tests/kraken/driver.html?testName=imaging-desaturate) 10:17:01 INFO - 2015-11-17 10:17:01,202 DEBUG : BROWSER_OUTPUT: RSS: Main: 156024832 10:17:01 INFO - 2015-11-17 10:17:01,203 DEBUG : BROWSER_OUTPUT: 10:17:04 INFO - 2015-11-17 10:17:04,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:41664/tests/kraken/driver.html?testName=json-parse-financial) 10:17:04 INFO - 2015-11-17 10:17:04,623 DEBUG : BROWSER_OUTPUT: RSS: Main: 155525120 10:17:04 INFO - 2015-11-17 10:17:04,623 DEBUG : BROWSER_OUTPUT: 10:17:06 INFO - 2015-11-17 10:17:06,368 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:41664/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:17:06 INFO - 2015-11-17 10:17:06,933 DEBUG : BROWSER_OUTPUT: RSS: Main: 163409920 10:17:06 INFO - 2015-11-17 10:17:06,934 DEBUG : BROWSER_OUTPUT: 10:17:08 INFO - 2015-11-17 10:17:08,805 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:17:09 INFO - 2015-11-17 10:17:09,412 DEBUG : BROWSER_OUTPUT: RSS: Main: 162791424 10:17:09 INFO - 2015-11-17 10:17:09,412 DEBUG : BROWSER_OUTPUT: 10:17:11 INFO - 2015-11-17 10:17:11,544 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:17:12 INFO - 2015-11-17 10:17:12,117 DEBUG : BROWSER_OUTPUT: RSS: Main: 172138496 10:17:12 INFO - 2015-11-17 10:17:12,117 DEBUG : BROWSER_OUTPUT: 10:17:14 INFO - 2015-11-17 10:17:14,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:17:15 INFO - 2015-11-17 10:17:15,231 DEBUG : BROWSER_OUTPUT: RSS: Main: 176205824 10:17:15 INFO - 2015-11-17 10:17:15,231 DEBUG : BROWSER_OUTPUT: 10:17:17 INFO - 2015-11-17 10:17:17,852 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:17:18 INFO - 2015-11-17 10:17:18,435 DEBUG : BROWSER_OUTPUT: RSS: Main: 175849472 10:17:18 INFO - 2015-11-17 10:17:18,435 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,172 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:41664/tests/kraken/driver.html?testName=ai-astar) 10:17:20 INFO - 2015-11-17 10:17:20,430 DEBUG : BROWSER_OUTPUT: RSS: Main: 234573824 10:17:20 INFO - 2015-11-17 10:17:20,430 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,430 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:17:20 INFO - 2015-11-17 10:17:20,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:17:20 INFO - 2015-11-17 10:17:20,430 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |0;ai-astar;109;114;105;115;113;113;101;111;116;110 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;155;140;162;173;131;157;151;135;174;131 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;162;163;161;163;163;163;163;161;162 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;73;84;94;73;72;74;127;89;74 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;93;126;91;93;94;128;91;92;128 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;110;110;110;110;109;109;110;110 10:17:20 INFO - 2015-11-17 10:17:20,431 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;147;148;148;148;147;149;148;148;147 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;96;95;96;96;96;96;95;95;95 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;68;69;69;70;68;67;68;76;65;66 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;69;69;69;68;69;68;69;69;69 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;83;85;83;85;83;83;83;83;83;85 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;120;128;125;122;126;127;121;127;119;121 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;144;164;141;153;153;147;147;155;134 10:17:20 INFO - 2015-11-17 10:17:20,432 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;70;71;69;69;68;68;69;73;68 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: __start_cc_report 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,986 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: __end_cc_report 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: __startTimestamp1447784240424__endTimestamp 10:17:20 INFO - 2015-11-17 10:17:20,433 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,434 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: Number of tests: 14 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.70 Median:113.00 stddev:4.69 (4.2%) stddev-sans-first:4.94 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: Values: 109.0 114.0 105.0 115.0 113.0 113.0 101.0 111.0 116.0 110.0 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:150.90 Median:156.00 stddev:16.20 (10.4%) stddev-sans-first:17.12 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: Values: 155.0 140.0 162.0 173.0 131.0 157.0 151.0 135.0 174.0 131.0 10:17:20 INFO - 2015-11-17 10:17:20,435 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:162.40 Median:163.00 stddev:0.84 (0.5%) stddev-sans-first:0.87 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: Values: 163.0 162.0 163.0 161.0 163.0 163.0 163.0 163.0 161.0 162.0 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:83.20 Median:74.00 stddev:17.31 (23.4%) stddev-sans-first:17.88 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: Values: 72.0 73.0 84.0 94.0 73.0 72.0 74.0 127.0 89.0 74.0 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:92.00 stddev:16.96 (18.4%) stddev-sans-first:17.54 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: Values: 92.0 93.0 126.0 91.0 93.0 94.0 128.0 91.0 92.0 128.0 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,436 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.80 Median:110.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 110.0 110.0 110.0 110.0 109.0 109.0 110.0 110.0 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:147.80 Median:148.00 stddev:0.63 (0.4%) stddev-sans-first:0.67 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: Values: 148.0 147.0 148.0 148.0 148.0 147.0 149.0 148.0 148.0 147.0 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.50 Median:96.00 stddev:0.53 (0.5%) stddev-sans-first:0.53 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: Values: 95.0 96.0 95.0 96.0 96.0 96.0 96.0 95.0 95.0 95.0 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:68.60 Median:68.50 stddev:2.99 (4.4%) stddev-sans-first:3.16 10:17:20 INFO - 2015-11-17 10:17:20,437 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 70.0 68.0 67.0 68.0 76.0 65.0 66.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.70 Median:69.00 stddev:0.48 (0.7%) stddev-sans-first:0.44 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: Values: 68.0 69.0 69.0 69.0 68.0 69.0 68.0 69.0 69.0 69.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.60 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 83.0 85.0 83.0 83.0 83.0 83.0 83.0 85.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.60 Median:125.50 stddev:3.34 (2.7%) stddev-sans-first:3.28 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: Values: 120.0 128.0 125.0 122.0 126.0 127.0 121.0 127.0 119.0 121.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.80 Median:151.50 stddev:8.27 (5.5%) stddev-sans-first:8.76 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: Values: 150.0 144.0 164.0 141.0 153.0 153.0 147.0 147.0 155.0 134.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:69.40 Median:69.00 stddev:1.58 (2.3%) stddev-sans-first:1.67 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 71.0 69.0 69.0 68.0 68.0 69.0 73.0 68.0 10:17:20 INFO - 2015-11-17 10:17:20,438 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:17:20 INFO - 2015-11-17 10:17:20,439 DEBUG : BROWSER_OUTPUT: 10:17:21 INFO - 2015-11-17 10:17:21,415 INFO : Browser exited with error code: 0 10:17:21 INFO - 2015-11-17 10:17:21,469 INFO : Completed test kraken (00:01:00) 10:17:21 INFO - 2015-11-17 10:17:21,470 INFO : Starting test v8_7 10:17:21 INFO - 2015-11-17 10:17:21,470 DEBUG : operating with platform_type : linux_ 10:17:21 INFO - 2015-11-17 10:17:21,470 INFO : Initialising browser for v8_7 test... 10:17:21 INFO - 2015-11-17 10:17:21,476 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2SgN_A/profile http://localhost:41664/getInfo.html 10:17:25 INFO - 2015-11-17 10:17:25,419 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 10:17:25 INFO - 2015-11-17 10:17:25,420 DEBUG : BROWSER_OUTPUT: colorDepth:24 10:17:25 INFO - 2015-11-17 10:17:25,420 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 10:17:25 INFO - 2015-11-17 10:17:25,420 DEBUG : BROWSER_OUTPUT: __metrics 10:17:25 INFO - 2015-11-17 10:17:25,577 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 10:17:26 INFO - 2015-11-17 10:17:26,845 INFO : Browser initialized. 10:17:26 INFO - 2015-11-17 10:17:26,846 INFO : Running cycle 1/1 for v8_7 test... 10:17:26 INFO - 2015-11-17 10:17:26,846 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp2SgN_A/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 10:17:38 INFO - 2015-11-17 10:17:38,695 DEBUG : BROWSER_OUTPUT: RSS: Main: 141946880 10:17:38 INFO - 2015-11-17 10:17:38,695 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,095 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:41664/tests/v8_7/run.html (next: http://localhost:41664/tests/v8_7/run.html) 10:18:00 INFO - 2015-11-17 10:18:00,346 DEBUG : BROWSER_OUTPUT: RSS: Main: 440209408 10:18:00 INFO - 2015-11-17 10:18:00,346 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,347 DEBUG : BROWSER_OUTPUT: __start_tp_report 10:18:00 INFO - 2015-11-17 10:18:00,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 10:18:00 INFO - 2015-11-17 10:18:00,347 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |0;Richards;163.50555918901242 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;196.34792852935402 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.7959416976279 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5065.656565656565 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2026.3157894736842 10:18:00 INFO - 2015-11-17 10:18:00,348 DEBUG : BROWSER_OUTPUT: |5;Earley;803.8585209003215 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: |6;Boyer;12587.5 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: |7;RegExp;26947.36842105263 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: |8;Splay;621.9739292364991 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: __end_tp_report 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: __startTimestamp1447784280347__endTimestamp 10:18:00 INFO - 2015-11-17 10:18:00,349 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,350 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 10:18:00 INFO - 2015-11-17 10:18:00,351 DEBUG : BROWSER_OUTPUT: Number of tests: 10 10:18:00 INFO - 2015-11-17 10:18:00,351 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.51 Median:163.51 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: Values: 163.5 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:196.35 Median:196.35 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: Values: 196.3 10:18:00 INFO - 2015-11-17 10:18:00,352 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.80 Median:285.80 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: Values: 285.8 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5065.66 Median:5065.66 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: Values: 5065.7 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2026.32 Median:2026.32 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,353 DEBUG : BROWSER_OUTPUT: Values: 2026.3 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:803.86 Median:803.86 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: Values: 803.9 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12587.50 Median:12587.50 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: Values: 12587.5 10:18:00 INFO - 2015-11-17 10:18:00,354 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26947.37 Median:26947.37 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: Values: 26947.4 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:621.97 Median:621.97 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: Values: 622.0 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 10:18:00 INFO - 2015-11-17 10:18:00,355 DEBUG : BROWSER_OUTPUT: Values: 4850.2 10:18:00 INFO - 2015-11-17 10:18:00,356 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 10:18:00 INFO - 2015-11-17 10:18:00,356 DEBUG : BROWSER_OUTPUT: 10:18:01 INFO - 2015-11-17 10:18:01,375 INFO : Browser exited with error code: 0 10:18:01 INFO - 2015-11-17 10:18:01,392 INFO : Completed test v8_7 (00:00:39) 10:18:01 INFO - 2015-11-17 10:18:01,866 INFO : Completed test suite (00:20:18) 10:18:01 INFO - 2015-11-17 10:18:01,866 DEBUG : Working with test: dromaeo_css 10:18:01 INFO - 2015-11-17 10:18:01,866 DEBUG : Generating results file: dromaeo_css 10:18:01 INFO - 2015-11-17 10:18:01,867 DEBUG : Working with test: kraken 10:18:01 INFO - 2015-11-17 10:18:01,867 DEBUG : Generating results file: kraken 10:18:01 INFO - 2015-11-17 10:18:01,867 INFO : javascript benchmark 10:18:01 INFO - 2015-11-17 10:18:01,868 DEBUG : Working with test: v8_7 10:18:01 INFO - 2015-11-17 10:18:01,868 DEBUG : Generating results file: v8_7 10:18:01 INFO - 2015-11-17 10:18:01,868 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:01 INFO - 2015-11-17 10:18:01,936 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,131,35]] 10:18:01 INFO - 2015-11-17 10:18:01,936 DEBUG : process_Request line: dromaeo_css 5961.12 graph.html#tests=[[72,131,35]] 10:18:01 INFO - 2015-11-17 10:18:01,936 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:01 INFO - 2015-11-17 10:18:01,975 DEBUG : process_Request line: kraken 1525.80 graph.html#tests=[[232,131,35]] 10:18:01 INFO - 2015-11-17 10:18:01,976 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:18:02 INFO - 2015-11-17 10:18:02,008 DEBUG : process_Request line: v8_7 19521.59 graph.html#tests=[[230,131,35]] 10:18:02 INFO - 2015-11-17 10:18:02,010 INFO : javascript benchmark 10:18:02 INFO - 2015-11-17 10:18:02,013 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2669.159214847323, 2755.063278485316, 2776.944461110778, 2777.2223777342324, 2779.4163225722596, 4568.154891345103, 4739.218029025206, 4746.382970213872, 4766.213574760165, 4807.951920480794, 4693.5306469353045, 4748.264019077049, 4758.50035746246, 4776.785044672989, 4831.975840120795, 4336.176126535964, 4410.911781764363, 4418.293073108303, 4453.910921781562, 4509.368688383613, 4441.866743997685, 4449.332600109977, 4493.033997690496, 4555.5899969002785, 4586.7018643788215, 4199.328107502785, 4322.805473753689, 4512.187806194884, 4557.179707652621, 4559.589636932676, 4315.697901146889, 4417.933730994006, 4431.7784110794655, 4437.933430998538, 4457.64338852891, 4403.185410699031, 4440.4893437254805, 4441.0, 4452.287633978548, 4493.4832494263255, 4520.367148599199, 4649.232876575361, 4663.953360466419, 4771.23660214364, 4796.328514008042, 5016.247562865563, 5039.622028347889, 5051.368578927634, 5060.797568097309, 5092.592592592584, 5001.449840517576, 5137.51193636604, 5146.794128234867, 5152.278680984665, 5192.3249977503065, 4555.06621142665, 4707.223308154184, 4720.598749106296, 4745.335653008616, 4768.594669453136, 5167.509086636764, 5260.13207820713, 5278.261043453919, 5283.498067683564, 5319.281896943863, 5092.26162206478, 5102.3877134743325, 5105.795768169231, 5108.6168537359845, 5114.565261952701, 4888.780004899788, 5011.0, 5011.4236862761245, 5181.4300426953005, 5223.242629818655, 4862.610991120702, 4945.950540494621, 4952.752362381866, 4953.504649535018, 4991.425986011583, 5036.722980236123, 5038.294638750578, 5042.974785126051, 5050.974745126325, 5083.847484575469, 3782.167923056978, 3893.143508428141, 3894.9610503895165, 3906.3554513505524, 3942.329803933338, 3412.5563676722363, 3515.1563624730393, 3538.327717733622, 3561.28774245152, 3569.3575156471566, 4423.51341352451, 4424.7123936944, 4435.090806384684, 4435.090806384684, 4472.060867217856, 4955.108080545537, 5096.668716533413, 5185.325907631984, 5186.273921650972, 5224.693826543365, 4332.653387728974, 4343.435353404037, 4397.978010109929, 4417.2269852775635, 4445.488768791565, 4576.107659006462, 4577.176108300538, 4578.35902973584, 4587.220172570671, 4611.400517932647, 4667.416572928384, 4775.904481910273, 4862.708237505761, 4943.233798761198, 4986.825461108844, 4997.2504124380175, 5054.7978080876355, 5072.391313042459, 5114.028334616411, 5139.254808052886, 4865.854024379274, 4868.41579010521, 4870.80516779339, 4881.121398148225, 4905.166121759381, 4838.7822547986125, 4955.628327875496, 5064.594832413324, 5069.062223488666, 5102.566281866083, 5083.5678967288195, 5095.87260318495, 5209.635325527177, 5211.114110601131, 5223.242629818579, 5067.493250674903, 5077.644564880571, 5084.923726144185, 5088.771005304696, 5140.280360749423, 4772.284157376422, 4904.509549045067, 5062.898742025065, 5072.492750724898, 5074.670146440617, 4779.784909679142, 4853.684510506806, 4879.268109783561, 4888.90222195547, 4904.092742842586, 5009.173486374853, 5020.874478138076, 5022.372203474566, 5029.59763218949, 5036.496350364934, 4706.411698537683, 4920.753962301942, 4926.556609905126, 4927.728974906271, 4956.578690811321], "unit": "ms", "name": "dojo.html", "value": 4669.533754925688}, {"lowerIsBetter": false, "replicates": [544.3114460207838, 560.5991715923116, 570.7117905457743, 578.910268908319, 592.4756590417479, 27774.166774996756, 36360.45459318109, 36780.0, 36809.44785828215, 36815.44776828343, 39508.80245598775, 40250.79874600623, 40273.597264027354, 40280.79859600705, 40331.79834100825, 6915.308469153095, 7044.22513523512, 7664.92335076649, 7908.841823163533, 7911.8417631647335, 9735.56189971453, 9883.209343252522, 9884.308098433112, 9913.405195688245, 9997.400155990628, 9883.406995580252, 10006.299559030871, 10008.449535275557, 10009.649662261785, 10018.39889606626, 6997.1603407591165, 7243.311885370881, 7259.165196002475, 9831.0, 9925.205983521373, 9680.854787178198, 9816.705498834976, 9824.950875245579, 9828.606855725762, 9833.459159746211, 36446.45330320048, 36714.265714685556, 36762.44856327157, 36861.631383686086, 36875.446868297, 2494.787943024845, 2692.25962860215, 2700.9729902701115, 2711.173092206876, 2857.8999735009174, 27570.0, 27642.308942276602, 28041.439171216665, 28056.859715701292, 28118.156455306373, 2955.8126986030184, 2980.2251414632133, 2991.476491613959, 3033.924151896198, 3056.9235769105726, 230709.0, 231107.9999999983, 231263.0, 231373.0, 231867.0, 47879.76060119677, 48738.5126148734, 51845.74077129666, 52171.73914130405, 52547.73726131345, 49152.75423622859, 49209.507904920494, 49393.50606493961, 49491.50508494941, 49539.752301238266, 12491.188072775241, 12555.748885022249, 12682.365881705879, 12693.238405695687, 12695.365231738377, 9632.0, 9635.951820240994, 9643.951780241054, 9663.082007209305, 9731.318807683394, 17402.47792566225, 17547.47357579275, 17673.646527069388, 17685.911570442066, 17723.582113430894, 7224.747133850396, 7430.368418684472, 7448.9627551861895, 7519.323260906544, 7536.660850261751, 785.7564155111934, 856.6188046319453, 891.7592250092569, 1016.598443614768, 1057.5981127171626, 25367.746322536907, 25918.74081259201, 26405.207843764718, 26981.595276070482, 27020.32449188786, 889.644142343068, 908.895477020138, 923.1922068190333, 932.5756780664781, 1039.9064084232455, 12164.33096179701, 12432.564860229848, 12449.190802597803, 12465.875341246472, 12512.0, 253601.0, 261139.0, 261468.0, 261918.0, 262048.0, 43823.780881095394, 44081.338779918326, 44210.77894610506, 44233.33649995253, 44272.11455770931, 1167.0721776187952, 1174.307158776309, 1174.3306315400312, 1175.353555544447, 1184.573553520749, 19652.50868728236, 25664.486710266065, 27275.318117046438, 27702.307442314104, 27815.860920695268, 39360.40959385669, 39748.80125599354, 39782.60217397789, 39788.20423591454, 39858.0, 221570.0, 223093.0, 223412.0, 223624.0, 224359.0, 23411.414714632272, 26098.478030438906, 27078.458430831666, 27817.0, 27988.44023119567, 32535.18662033468, 32703.34593308168, 37129.6287037137, 37896.621033789306, 38235.0, 31126.22184445407, 31359.529607055458, 31872.0, 32326.0, 32651.510227346134, 30831.38337233198, 31353.0, 31709.048728538182, 31797.0, 31823.522647160775, 31775.523367149974, 31822.681773181972, 31869.840650797527, 31920.201994950312, 34701.47947780836, 32458.83770581132, 34989.650103499655, 35542.28915421729, 36019.0, 36319.0, 27959.720402795712, 29099.0, 30678.846605766827, 30729.574360943083, 30848.537271941386], "unit": "ms", "name": "ext.html", "value": 16690.145262139256}, {"lowerIsBetter": false, "replicates": [338.51085181912134, 338.839051450561, 340.3329474230508, 341.8786330852547, 343.02922728677845, 11920.7615847683, 12316.568920087799, 14703.926480367596, 14775.778363324545, 16545.834541654578, 10958.671239862797, 11266.267692599975, 11290.040346570551, 14855.480058197938, 15339.309731062101, 4145.606167414091, 4179.498460184782, 4264.786760661955, 4267.210566045276, 4276.807543660543, 3179.364127174563, 3260.755443341747, 4731.78706958186, 4846.466888642247, 4848.854534363974, 4768.094062128184, 4783.449903261135, 4792.616590672737, 4794.113089078514, 4797.11253418117, 4676.0, 4779.450363208223, 4780.760961951889, 4825.20384136617, 4831.130396528606, 4150.149219410014, 4152.854650087233, 4159.376093585956, 4159.9376009359885, 4160.313548264533, 12875.871241287561, 13090.607281781466, 13182.802257966137, 13211.801822972662, 13221.669458263525, 1581.5966928433177, 1586.420956350935, 1699.209867411647, 1749.3527394863981, 1759.0589034866284, 9396.107369799858, 9504.572294246775, 9507.90492095077, 9790.755231119208, 9814.362066465728, 1593.6573636668056, 1595.505393328072, 1634.983650163495, 1675.7821483207106, 1703.5059832648517, 53738.46261537373, 53792.0, 54386.0, 54447.0, 55241.72379138119, 6606.10817539626, 6730.394264516217, 6732.360425759545, 6740.797776066725, 6767.695453704497, 7979.760607181794, 7997.160298168725, 8005.719799806979, 8009.199080091944, 8009.23912228349, 4807.759612019455, 4866.78099485524, 4951.331570238044, 4984.551390374883, 4996.725180115056, 4864.683795553277, 4904.509549045067, 4930.482299358516, 4932.8520144395725, 4937.925931111036, 3060.127863558875, 3099.1942095055447, 3125.4374212641487, 3127.62468503781, 3130.201798541357, 1069.540097757956, 1076.4294923690456, 1101.911847052234, 1109.8358201507094, 1153.1236260442124, 417.0928231097351, 433.462506491954, 444.3334997503744, 447.0187937477271, 488.2310361181083, 10471.581136754445, 10885.891141088488, 10901.236913415985, 10910.181736369805, 10935.56257749697, 415.46820070310054, 427.3098945203474, 465.59958435745233, 469.92951057341674, 472.5581581221569, 5876.382979787147, 5959.225300710967, 6036.486898613667, 6040.093985902062, 6065.969670151621, 444250.0, 447981.0, 456785.0, 464398.0, 465622.0, 63652.0, 65164.67417662881, 65278.70386035438, 65978.67010665013, 66242.0, 515.7112017270341, 515.7215103843957, 520.4301290087349, 520.6147450886392, 521.3326941514867, 10202.795944081225, 10208.489575521342, 10271.94864025675, 10364.740881478023, 10418.166546676097, 31221.375572488876, 31625.0, 31741.20646983844, 31942.840285798422, 32203.51694724628, 41642.0, 41964.79017605015, 43183.0, 43698.563014370724, 44158.0, 6161.784337548164, 6431.421172094534, 6507.609543427409, 6509.902351464826, 6514.609123452608, 11226.887731122912, 11355.54577816878, 11432.94283528577, 11491.827622585835, 11541.0, 8304.460210086325, 8587.570621469027, 9437.433753974783, 9457.38526995743, 9659.806803864023, 8692.91307086921, 8859.24696400813, 9703.0, 9818.459984700625, 10028.64899728506, 9401.717948461557, 9430.575624096795, 9898.505074746377, 9931.404115753077, 9937.801243974935, 11717.76564468723, 11740.471678774305, 12749.17130386522, 12940.0, 13496.32518374097, 13933.164010159422, 14605.85394146045, 15099.6780708244, 15354.155521446428, 15506.379744810081], "unit": "ms", "name": "jquery.html", "value": 6574.656773556612}, {"lowerIsBetter": false, "replicates": [1350.655582826379, 1379.6688794689278, 1419.6379923119607, 1490.426185918421, 1645.794275715535, 6002.279726432828, 6578.375054369833, 6920.723171073158, 6924.861502769942, 6934.098567186259, 6780.49146314026, 6889.827754306132, 6894.345037221468, 6899.448044156468, 6899.827504312395, 1735.8871673341193, 1765.9028753418556, 1767.4874286456911, 2044.5297581556215, 2059.5160137367707, 1762.3391228289393, 1771.0, 2034.7660019097846, 2069.937901862939, 2077.2937201351538, 2028.878267303959, 2034.4608678700156, 2040.2043203150708, 2041.2753472517265, 2042.428120126367, 1958.4418440744391, 2001.7497812773404, 2005.3081686818098, 2006.3579654510563, 2008.7087372331002, 2028.2698228637678, 2048.795120487954, 2072.253988564116, 2075.2529089527757, 2075.3670130610158, 6888.276730943229, 6974.232834388264, 6976.232614412411, 6986.126734158231, 6990.895136572904, 4127.938080928789, 4176.227397931392, 4201.70588058836, 4217.641500472463, 4220.029393239542, 2616.6859976802716, 2664.0, 2687.7446642568925, 2715.117586784303, 2718.347596576827, 836.7615229659518, 842.2630198576246, 845.1168528887328, 876.9123087691244, 883.779055236191, 9247.491387973727, 9257.907420925772, 9269.304802139866, 9279.39683920543, 9333.06669333068, 3848.634379733921, 3871.05159235989, 3936.606339366098, 3987.720859539804, 4009.959900401017, 8120.269175774209, 8125.02499700028, 8125.187481251945, 8129.268365846984, 8168.06067302256, 4159.729617574848, 4173.373993900878, 4174.540800511942, 4175.415441838145, 4181.874543763692, 3736.9626303736613, 3744.2137151198554, 3754.2303827715255, 3756.1360886996144, 3758.4550240215563, 3446.0, 3448.9310213796084, 3464.7055000325254, 3473.7568370213844, 3492.738044646611, 946.0444950599943, 949.5774380400655, 1129.824877144044, 1144.2562334482486, 1151.8272259161192, 853.0744142605218, 858.6350800909588, 859.5616235719828, 911.5852287209303, 1036.3471013261596, 6220.377962203744, 6296.590721603081, 6330.620162790247, 6330.715117819709, 6335.746570137235, 975.1223898491414, 989.4805227255748, 1005.9647912323034, 1016.1667432705111, 1020.4489575629077, 4744.074905393415, 4861.392325959255, 4877.365942427462, 4882.9257563336005, 4888.486708895514, 8296.8340633187, 8418.200270974248, 8437.535935523605, 8474.491530508067, 8487.660493580188, 8077.959610202029, 8417.70538031166, 8423.873641895376, 8431.241188293083, 8437.114103019094, 6621.437177839841, 6676.666166691646, 6709.664516774142, 6716.126903502513, 6732.596044237263, 6046.425589568984, 6067.089936509559, 6160.691965401622, 6209.720562574605, 6212.502999760099, 7345.375643070399, 7517.436192285491, 7518.173000969779, 7568.735094271674, 7608.505447145918, 7557.206493318123, 7637.770866874002, 7644.847103058019, 7749.7675069748, 7761.573113478587, 5994.400559943971, 6101.237345331833, 6107.9083813741945, 6116.17431646722, 6116.908246376219, 5705.486506214461, 6262.812115636538, 6317.147185129948, 6320.367963203643, 6322.525810564318, 5348.759305831325, 5707.0583353747825, 6108.0, 6120.173776540289, 6229.56393052482, 6214.689265536796, 6260.436560709558, 6275.435210831047, 6340.461060809883, 6384.233891932998, 6254.343293954069, 6280.403361680633, 6281.089242059785, 6288.5283603728985, 6288.773689130576, 5725.227094342377, 5750.079987202028, 5751.338596061507, 5753.079507278815, 5758.539316854725, 5836.620619659879, 5855.970720146372, 5899.793507227227, 5914.290285165807, 5916.023856063874], "unit": "ms", "name": "mootools.html", "value": 3957.460562098933}, {"lowerIsBetter": false, "replicates": [311.72879594752567, 315.0705419013908, 316.9334439767649, 321.59318462145393, 322.8579425052978, 5307.840764777058, 5530.05988981873, 5551.944480555193, 5579.832605021851, 5583.972080139593, 5369.5972802039805, 5430.75561599728, 5439.5376393006545, 5449.427810079934, 5454.645448045874, 3970.920581588381, 4045.0898547826796, 4091.2022155679656, 4217.662586993033, 4220.53574106848, 4182.89153374356, 4191.55988621195, 4197.454330936989, 4209.557996410379, 4220.915581688364, 4162.646175075122, 4162.771047592381, 4167.249895018896, 4170.291050521419, 4171.311733563958, 3924.666403355718, 3995.3407687731487, 4050.858219962287, 4168.333066709312, 4173.520045194811, 3645.908852278688, 3649.069487280753, 3650.7079433645245, 3652.506911566931, 3653.5250417445563, 5199.974000129975, 5220.686758794446, 5223.2165175223645, 5224.555912747421, 5225.712585807779, 4819.975900120512, 4828.879278018043, 4832.589229915427, 4833.347498087748, 4833.984863178736, 5567.248421463091, 5724.313082430093, 5734.254546908917, 5757.769689212427, 5786.987277226469, 4055.1889622075705, 4068.044009657728, 4071.1247081877536, 4072.572379900127, 4119.155573107506, 5972.9701351493395, 6051.304100028509, 6056.182415373913, 6061.212042434499, 6063.393660633989, 4227.281362168439, 4228.6617070634275, 4231.830726770956, 4232.217039847638, 4232.978835105805, 4202.894927626772, 4294.7852607369505, 4299.1831552005015, 4303.763293018851, 4312.835534405693, 4845.878853028703, 4860.0, 4861.489543597942, 4862.343583616237, 4864.562189402971, 5737.8565535861935, 5748.741306641127, 5749.281339832521, 5749.310082790092, 5751.022326204472, 1507.9321430535651, 1531.9693606127814, 1532.3564103076735, 1533.7776022476678, 1533.9846601534066, 1043.9895601043893, 1048.4076496779448, 1055.757175849559, 1071.0414179309475, 1080.9459527023616, 5043.646944713908, 5049.141645920129, 5051.545360917535, 5054.696718196847, 5055.292259083732, 5964.761409543657, 5969.104634304889, 5969.164316995624, 5969.253843269591, 5969.880602387928, 5036.143855544567, 5055.620828437882, 5056.0, 5057.14028615129, 5064.392272927273, 2993.5060714981782, 3101.1936896407096, 3198.200449887528, 3213.951790723141, 3259.869605215812, 5665.0, 5673.8297851064535, 5675.489205971482, 5686.687232202268, 5690.5447564194765, 6183.196184495987, 6183.227096612924, 6187.628742275388, 6189.659568723763, 6198.473129784019, 5552.472515111058, 5668.093105103246, 5670.971645141748, 5678.716064196857, 5680.034394153004, 5960.672163031075, 5990.7304171311525, 5993.730282137227, 6008.309044459943, 6011.398860114128, 5825.883482330414, 5830.941690583039, 5832.037713777349, 5838.737256823369, 5839.737211825393, 5660.575456840836, 5663.603547751618, 5667.971660141673, 5668.319801623831, 5673.290838645169, 4028.0, 4149.294619914682, 4170.249355116108, 4269.594388533084, 4276.48682158143, 5972.432618901197, 5972.820815375546, 5972.850678733066, 5974.970125149346, 5976.402359763989, 5748.0, 5751.511121554715, 5754.856128596819, 5758.1650660654805, 5760.481556659921, 5630.690312032713, 5736.741846616996, 5749.856253593526, 5750.942490575041, 5752.654840709571, 5604.439556044526, 5611.523020543136, 5623.2408624835125, 5629.915551266816, 5630.831075067755, 5786.537077033743, 5790.913136303043, 5792.189093526826, 5792.21805056312, 5792.507636850914, 5411.918821217606, 5591.245181900554, 5617.213590097308, 5621.325440947113, 5625.46558076982], "unit": "ms", "name": "prototype.html", "value": 4331.960532750052}, {"lowerIsBetter": false, "replicates": [672.7981605518345, 694.1773997812593, 694.9548279361844, 711.7722328854766, 727.4507746651277, 10865.293755905861, 11129.610463633775, 11144.275622084559, 11147.108231341494, 11152.163587730913, 11008.944955275232, 11051.336919784819, 11074.944625276883, 11089.05743011843, 11117.5552977881, 758.4652819762055, 774.2064384006383, 774.7365895595497, 774.9341305988969, 775.2751177648917, 602.0367412140562, 607.6870411737937, 763.2177018555969, 778.3734094054313, 782.5343920367372, 819.3649921310972, 820.7660816667251, 827.2182787266036, 827.5407149032285, 827.6358402302998, 618.7246675229525, 817.1256755271861, 818.1000899011041, 818.4966245758875, 818.8157664525494, 462.76630301697764, 583.422411812307, 593.9316978547479, 594.191899017336, 594.509529638046, 11096.944515277453, 11144.164187685956, 11148.554057837677, 11155.832662510069, 11163.106951443864, 10073.194144468425, 10182.439965801877, 10209.0, 10219.437930913797, 10803.027727504485, 8429.32565394767, 8527.829443411098, 8580.18488243622, 8630.395872288942, 8683.956580217058, 3096.9380612387627, 3162.5256211568217, 3189.282411457427, 3189.9681003190135, 3197.2006998250436, 39493.60506394928, 39643.0, 39753.0, 39845.40231896495, 39948.20103597912, 7828.334591559781, 7843.333316668033, 7871.134175240719, 7921.287084162453, 8001.759947201594, 14406.711865762625, 14442.927785361217, 14458.20479873596, 14470.855291446951, 14474.059186152866, 5679.091345384719, 5744.396838331999, 5771.163181338682, 5792.739326730307, 5950.256217972754, 3380.1042723678247, 3430.811305378178, 3473.513708080871, 3482.6169121396624, 3509.298140371936, 2351.494428697804, 2385.4990452004927, 2490.4396510784927, 2542.1992072497105, 2544.5928651415684, 439.1086095226695, 439.90981848720935, 445.72365133616717, 446.43303005183884, 447.40941956617604, 378.26238834272726, 382.6776558768714, 394.5699187885219, 410.5832579931372, 416.28814726816876, 6283.2460104787715, 6310.652914089677, 6395.776147834897, 6400.583962042452, 6466.159399278158, 330.1021222275407, 402.90531725044593, 453.53739186030725, 507.8958813443235, 509.0734862550123, 3085.2414123949584, 3096.3342881280632, 3107.300857307133, 3166.224275052627, 3181.618205815317, 46437.30344044842, 48515.51484485181, 48768.26847597289, 48939.0, 51771.48228517742, 45582.31626525605, 45646.771766140955, 45775.0, 46389.30416043762, 47588.5241147591, 40922.59077409188, 41624.1675166495, 41865.58134418678, 42570.14859702789, 42745.57254427478, 6304.6129851432615, 6555.868882622416, 6778.627175505198, 6781.728730850711, 6847.965760171167, 31584.526232106997, 31729.365412692077, 32305.35389292154, 32415.35169296648, 32768.836155819066, 36216.275674485834, 36327.27345453129, 36337.0, 39768.801155994035, 40181.397279040255, 6663.8667226654225, 6733.6296503692765, 6780.72877084911, 6784.59292442455, 6956.756513522205, 9549.140577348073, 9559.808803824024, 9568.947415784398, 9605.087516686182, 9705.951470242604, 8176.0, 8201.097879233399, 8216.507009579444, 8221.342292616457, 8364.874526882224, 8317.168283171635, 8540.274076703301, 8710.433821801562, 8775.56122193875, 8786.297096232414, 7502.587357695161, 8440.409171357946, 8476.0, 8613.741587752378, 8697.95651021741, 7444.888326675213, 7531.133919599316, 7992.840143196987, 8028.638711258124, 8220.342372610057, 7106.324899134574, 7180.748673796392, 7272.454565907472, 7395.371393431404, 7579.204183560867], "unit": "ms", "name": "yui.html", "value": 5107.581407943703}], "name": "dromaeo_css", "value": 5961.117449808629}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [109.0, 114.0, 105.0, 115.0, 113.0, 113.0, 101.0, 111.0, 116.0, 110.0], "unit": "ms", "name": "ai-astar", "value": 110.7}, {"lowerIsBetter": true, "replicates": [155.0, 140.0, 162.0, 173.0, 131.0, 157.0, 151.0, 135.0, 174.0, 131.0], "unit": "ms", "name": "audio-beat-detection", "value": 150.9}, {"lowerIsBetter": true, "replicates": [163.0, 162.0, 163.0, 161.0, 163.0, 163.0, 163.0, 163.0, 161.0, 162.0], "unit": "ms", "name": "audio-dft", "value": 162.4}, {"lowerIsBetter": true, "replicates": [72.0, 73.0, 84.0, 94.0, 73.0, 72.0, 74.0, 127.0, 89.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 83.2}, {"lowerIsBetter": true, "replicates": [92.0, 93.0, 126.0, 91.0, 93.0, 94.0, 128.0, 91.0, 92.0, 128.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 110.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 110.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.8}, {"lowerIsBetter": true, "replicates": [148.0, 147.0, 148.0, 148.0, 148.0, 147.0, 149.0, 148.0, 148.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 147.8}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0, 95.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.5}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 70.0, 68.0, 67.0, 68.0, 76.0, 65.0, 66.0], "unit": "ms", "name": "json-parse-financial", "value": 68.6}, {"lowerIsBetter": true, "replicates": [68.0, 69.0, 69.0, 69.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.7}, {"lowerIsBetter": true, "replicates": [83.0, 85.0, 83.0, 85.0, 83.0, 83.0, 83.0, 83.0, 83.0, 85.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.6}, {"lowerIsBetter": true, "replicates": [120.0, 128.0, 125.0, 122.0, 126.0, 127.0, 121.0, 127.0, 119.0, 121.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.6}, {"lowerIsBetter": true, "replicates": [150.0, 144.0, 164.0, 141.0, 153.0, 153.0, 147.0, 147.0, 155.0, 134.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.8}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 71.0, 69.0, 69.0, 68.0, 68.0, 69.0, 73.0, 68.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 69.4}], "name": "kraken", "value": 1525.7999999999997}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.50555918901242], "unit": "score", "name": "Richards", "value": 215.90703200000004}, {"lowerIsBetter": false, "replicates": [196.34792852935402], "unit": "score", "name": "DeltaBlue", "value": 336.7389739999999}, {"lowerIsBetter": false, "replicates": [285.7959416976279], "unit": "score", "name": "Encrypt", "value": 931.3673189999998}, {"lowerIsBetter": false, "replicates": [5065.656565656565], "unit": "score", "name": "Decrypt", "value": 52.54619940179463}, {"lowerIsBetter": false, "replicates": [2026.3157894736842], "unit": "score", "name": "RayTrace", "value": 365.18937662337675}, {"lowerIsBetter": false, "replicates": [803.8585209003215], "unit": "score", "name": "Earley", "value": 829.0799720000001}, {"lowerIsBetter": false, "replicates": [12587.5], "unit": "score", "name": "Boyer", "value": 52.946415094339656}, {"lowerIsBetter": false, "replicates": [26947.36842105263], "unit": "score", "name": "RegExp", "value": 33.80608398437501}, {"lowerIsBetter": false, "replicates": [621.9739292364991], "unit": "score", "name": "Splay", "value": 131.01996107784433}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19521.58645880534}]} 10:18:02 INFO - RETURN: dromaeo_css: 5961.12 10:18:02 INFO - RETURN: kraken: 1525.80 10:18:02 INFO - RETURN: v8_7: 19521.59 10:18:02 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,131,35]]", "result": "19521.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,131,35]]", "result": "1525.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,131,35]]", "result": "5961.12"}}} 10:18:02 INFO - Return code: 0 10:18:02 INFO - # TBPL SUCCESS # 10:18:02 INFO - Running post-action listener: _resource_record_post_action 10:18:02 INFO - Running post-run listener: _resource_record_post_run 10:18:03 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 4096; Write bytes: 513912832; Read time: 252; Write time: 467552 10:18:03 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 166010880; Read time: 0; Write time: 88200 10:18:03 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 0; Write bytes: 289992704; Read time: 0; Write time: 287996 10:18:03 INFO - Running post-run listener: _upload_blobber_files 10:18:03 INFO - Blob upload gear active. 10:18:03 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 10:18:03 INFO - Copying logs to upload dir... 10:18:03 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1270.611511 ========= master_lag: 0.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 10 secs) (at 2015-11-17 10:18:02.265863) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 10:18:02.269630) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010088 build_url: 'https://queue.taskcluster.net/v1/task/1kB_WI6ETIq36E8azE_V2g/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-17 10:18:02.321698) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 10:18:02.322063) ========= 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=6e558709db315bacd2260379000001b6-1447782471.514496-331499448 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004601 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 10:18:02.372263) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 10:18:02.372627) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 10:18:02.372946) ========= ========= Total master_lag: 0.31 =========