builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-042 starttime: 1448025815.2 results: success (0) buildid: 20151120041233 builduid: b70b88be3af44ce8b2ffa292c6c0dc86 revision: 1b2e15608f34fef0f23369731c80138f55f00cf2 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.205112) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.205691) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.205969) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006548 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.228518) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.228819) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.284126) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.284447) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004610 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.349956) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.350454) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.350892) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.351283) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 05:23:35-- 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% 224M=0s 2015-11-20 05:23:35 (224 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.203035 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.572384) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.572735) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.017934 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.628706) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:35.629011) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 1b2e15608f34fef0f23369731c80138f55f00cf2 --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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 05:23:35,830 truncating revision to first 12 chars 2015-11-20 05:23:35,830 Setting DEBUG logging. 2015-11-20 05:23:35,830 attempt 1/10 2015-11-20 05:23:35,830 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1b2e15608f34?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 05:23:36,053 unpacking tar archive at: mozilla-central-1b2e15608f34/testing/mozharness/ program finished with exit code 0 elapsedTime=0.491119 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:36.135712) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:36.136013) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:36.145025) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:36.145307) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 05:23:36.145687) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-20 05:23:36.146017) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-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', 'Firefox-Non-PGO', '--system-bits', '64', '--cfg', 'talos/linux_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox-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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 05:23:36 INFO - MultiFileLogger online at 20151120 05:23:36 in /builds/slave/test 05:23:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox-Non-PGO --system-bits 64 --cfg talos/linux_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox-Non-PGO 05:23:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:23:36 INFO - {'append_to_log': False, 05:23:36 INFO - 'base_work_dir': '/builds/slave/test', 05:23:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 05:23:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:23:36 INFO - 'branch': 'Firefox-Non-PGO', 05:23:36 INFO - 'buildbot_json_path': 'buildprops.json', 05:23:36 INFO - 'config_files': ('talos/linux_config.py',), 05:23:36 INFO - 'default_actions': ('clobber', 05:23:36 INFO - 'read-buildbot-config', 05:23:36 INFO - 'download-and-extract', 05:23:36 INFO - 'populate-webroot', 05:23:36 INFO - 'create-virtualenv', 05:23:36 INFO - 'install', 05:23:36 INFO - 'run-tests'), 05:23:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:23:36 INFO - 'download_minidump_stackwalk': True, 05:23:36 INFO - 'download_symbols': 'ondemand', 05:23:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:23:36 INFO - 'tooltool.py': '/tools/tooltool.py', 05:23:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:23:36 INFO - '/tools/misc-python/virtualenv.py')}, 05:23:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:23:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:23:36 INFO - 'installer_path': 'installer.exe', 05:23:36 INFO - 'log_level': 'info', 05:23:36 INFO - 'log_name': 'talos', 05:23:36 INFO - 'log_to_console': True, 05:23:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 05:23:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 05:23:36 INFO - 'opt_config_files': (), 05:23:36 INFO - 'pip_index': False, 05:23:36 INFO - 'sps_profile': False, 05:23:36 INFO - 'sps_profile_interval': 0, 05:23:36 INFO - 'suite': 'dromaeojs', 05:23:36 INFO - 'system_bits': '64', 05:23:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:23:36 INFO - 'title': 'talos-linux64-ix-042', 05:23:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:23:36 INFO - 'use_talos_json': True, 05:23:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:23:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:23:36 INFO - 'work_dir': 'build'} 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running clobber step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: clobber 05:23:36 INFO - rmtree: /builds/slave/test/build 05:23:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running read-buildbot-config step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: read_buildbot_config 05:23:36 INFO - Using buildbot properties: 05:23:36 INFO - { 05:23:36 INFO - "properties": { 05:23:36 INFO - "buildnumber": 364, 05:23:36 INFO - "product": "firefox", 05:23:36 INFO - "script_repo_revision": "production", 05:23:36 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 05:23:36 INFO - "repository": "", 05:23:36 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 05:23:36 INFO - "buildid": "20151120041233", 05:23:36 INFO - "slavename": "talos-linux64-ix-042", 05:23:36 INFO - "pgo_build": "False", 05:23:36 INFO - "basedir": "/builds/slave/test", 05:23:36 INFO - "project": "", 05:23:36 INFO - "platform": "ubuntu64_hw", 05:23:36 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 05:23:36 INFO - "slavebuilddir": "test", 05:23:36 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 05:23:36 INFO - "branch": "mozilla-central", 05:23:36 INFO - "repo_path": "mozilla-central", 05:23:36 INFO - "stage_platform": "linux64", 05:23:36 INFO - "builduid": "b70b88be3af44ce8b2ffa292c6c0dc86", 05:23:36 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 05:23:36 INFO - }, 05:23:36 INFO - "sourcestamp": { 05:23:36 INFO - "repository": "", 05:23:36 INFO - "hasPatch": false, 05:23:36 INFO - "project": "", 05:23:36 INFO - "branch": "mozilla-central-linux64-talos", 05:23:36 INFO - "changes": [ 05:23:36 INFO - { 05:23:36 INFO - "category": null, 05:23:36 INFO - "files": [ 05:23:36 INFO - { 05:23:36 INFO - "url": null, 05:23:36 INFO - "name": "https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 05:23:36 INFO - } 05:23:36 INFO - ], 05:23:36 INFO - "repository": "", 05:23:36 INFO - "rev": "1b2e15608f34fef0f23369731c80138f55f00cf2", 05:23:36 INFO - "who": "cbook@mozilla.com", 05:23:36 INFO - "when": 1448025753, 05:23:36 INFO - "number": 6688370, 05:23:36 INFO - "comments": "Merge m-c to f-t", 05:23:36 INFO - "project": "", 05:23:36 INFO - "at": "Fri 20 Nov 2015 05:22:33", 05:23:36 INFO - "branch": "mozilla-central-linux64-talos", 05:23:36 INFO - "revlink": "", 05:23:36 INFO - "properties": [ 05:23:36 INFO - [ 05:23:36 INFO - "buildid", 05:23:36 INFO - "20151120041233", 05:23:36 INFO - "Change" 05:23:36 INFO - ], 05:23:36 INFO - [ 05:23:36 INFO - "builduid", 05:23:36 INFO - "b70b88be3af44ce8b2ffa292c6c0dc86", 05:23:36 INFO - "Change" 05:23:36 INFO - ], 05:23:36 INFO - [ 05:23:36 INFO - "pgo_build", 05:23:36 INFO - "False", 05:23:36 INFO - "Change" 05:23:36 INFO - ] 05:23:36 INFO - ], 05:23:36 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 05:23:36 INFO - } 05:23:36 INFO - ], 05:23:36 INFO - "revision": "1b2e15608f34fef0f23369731c80138f55f00cf2" 05:23:36 INFO - } 05:23:36 INFO - } 05:23:36 INFO - Found installer url https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 05:23:36 INFO - Running post-action listener: _resource_record_post_action 05:23:36 INFO - ##### 05:23:36 INFO - ##### Running download-and-extract step. 05:23:36 INFO - ##### 05:23:36 INFO - Running pre-action listener: _resource_record_pre_action 05:23:36 INFO - Running main action method: download_and_extract 05:23:36 INFO - mkdir: /builds/slave/test/build/tests 05:23:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:36 INFO - https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:23:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/test_packages.json 05:23:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/test_packages.json 05:23:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:23:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:23:37 INFO - Downloaded 1302 bytes. 05:23:37 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:23:37 INFO - Using the following test package requirements: 05:23:37 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:37 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 05:23:37 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'jsshell-linux-x86_64.zip'], 05:23:37 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 05:23:37 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:37 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 05:23:37 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 05:23:37 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 05:23:37 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 05:23:37 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 05:23:37 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 05:23:37 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 05:23:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:37 INFO - https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:39 INFO - Downloaded 21339116 bytes. 05:23:39 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] in /builds/slave/test/build/tests 05:23:39 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:39 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] with output_timeout 1760 05:23:40 INFO - Return code: 0 05:23:40 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'] for test suite category: talos 05:23:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:40 INFO - https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 05:23:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:46 INFO - Downloaded 21339116 bytes. 05:23:46 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 05:23:46 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 05:23:46 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 05:23:48 INFO - Return code: 0 05:23:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:48 INFO - https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 05:23:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:49 INFO - Downloaded 11130997 bytes. 05:23:49 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 05:23:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 05:23:49 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 05:23:49 INFO - Return code: 0 05:23:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:49 INFO - https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 05:23:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:23:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:23:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ipyeiuzDRmigHfkWVwdBbw/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 05:23:51 INFO - Downloaded 55782567 bytes. 05:23:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:23:51 INFO - mkdir: /builds/slave/test/properties 05:23:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:23:51 INFO - Writing to file /builds/slave/test/properties/build_url 05:23:51 INFO - Contents: 05:23:51 INFO - build_url:https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 05:23:51 INFO - Running post-action listener: _resource_record_post_action 05:23:51 INFO - Running post-action listener: set_extra_try_arguments 05:23:51 INFO - ##### 05:23:51 INFO - ##### Running populate-webroot step. 05:23:51 INFO - ##### 05:23:51 INFO - Running pre-action listener: _resource_record_pre_action 05:23:51 INFO - Running main action method: populate_webroot 05:23:51 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:23:51 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:23:51 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:23:51 INFO - '../fennec_ids.txt'], 05:23:51 INFO - 'tests': ['tcheck2']}, 05:23:51 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:23:51 INFO - '--tppagecycles', 05:23:51 INFO - '7'], 05:23:51 INFO - 'tests': ['tsvgm']}}, 05:23:51 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:23:51 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:23:51 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:23:51 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:23:51 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:51 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:23:51 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'tests': ['damp', 'tps']}, 05:23:51 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['damp', 'tps']}, 05:23:51 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:23:51 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:23:51 INFO - 'other': {'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'other_l64': {'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'other_nol64': {'tests': ['a11yr', 05:23:51 INFO - 'ts_paint', 05:23:51 INFO - 'tpaint', 05:23:51 INFO - 'sessionrestore', 05:23:51 INFO - 'sessionrestore_no_auto_restore']}, 05:23:51 INFO - 'svgr': {'tests': ['tsvgx', 05:23:51 INFO - 'tsvgr_opacity', 05:23:51 INFO - 'tart', 05:23:51 INFO - 'tscrollx', 05:23:51 INFO - 'cart']}, 05:23:51 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['tsvgx', 05:23:51 INFO - 'tsvgr_opacity', 05:23:51 INFO - 'tart', 05:23:51 INFO - 'tscrollx', 05:23:51 INFO - 'cart']}, 05:23:51 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'tests': ['tp5o']}, 05:23:51 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'talos_options': ['--e10s'], 05:23:51 INFO - 'tests': ['tp5o']}, 05:23:51 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'talos_options': ['--xperf_path', 05:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:51 INFO - 'tests': ['tp5n']}, 05:23:51 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:23:51 INFO - 'talos_options': ['--e10s', 05:23:51 INFO - '--xperf_path', 05:23:51 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:23:51 INFO - 'tests': ['tp5n']}}, 05:23:51 INFO - 'talos.zip': {'path': '', 05:23:51 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:23:51 INFO - Running post-action listener: _resource_record_post_action 05:23:51 INFO - ##### 05:23:51 INFO - ##### Running create-virtualenv step. 05:23:51 INFO - ##### 05:23:51 INFO - Running pre-action listener: _resource_record_pre_action 05:23:51 INFO - Running main action method: create_virtualenv 05:23:51 INFO - Creating virtualenv /builds/slave/test/build/venv 05:23:51 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 05:23:51 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:23:51 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:23:51 INFO - Using real prefix '/usr' 05:23:51 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:23:51 INFO - Installing distribute.............................................................................................................................................................................................done. 05:23:53 INFO - Installing pip.................done. 05:23:53 INFO - Return code: 0 05:23:53 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:23:53 INFO - Using env: {'DISPLAY': ':0', 05:23:53 INFO - 'HOME': '/home/cltbld', 05:23:53 INFO - 'LANG': 'en_US.UTF-8', 05:23:53 INFO - 'LANGUAGE': 'en_US:en', 05:23:53 INFO - 'LOGNAME': 'cltbld', 05:23:53 INFO - 'MAIL': '/var/mail/cltbld', 05:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:53 INFO - 'MOZ_NO_REMOTE': '1', 05:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:53 INFO - 'NO_EM_RESTART': '1', 05:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:53 INFO - 'PWD': '/builds/slave/test', 05:23:53 INFO - 'SHELL': '/bin/bash', 05:23:53 INFO - 'SHLVL': '1', 05:23:53 INFO - 'TERM': 'linux', 05:23:53 INFO - 'TMOUT': '86400', 05:23:53 INFO - 'USER': 'cltbld', 05:23:53 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:53 INFO - '_': '/tools/buildbot/bin/python'} 05:23:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:53 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 05:23:53 INFO - Cleaning up... 05:23:53 INFO - Return code: 0 05:23:53 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:23: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')]} 05:23:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23: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')]} 05:23:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:53 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:23:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:23:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:23:53 INFO - Using env: {'DISPLAY': ':0', 05:23:53 INFO - 'HOME': '/home/cltbld', 05:23:53 INFO - 'LANG': 'en_US.UTF-8', 05:23:53 INFO - 'LANGUAGE': 'en_US:en', 05:23:53 INFO - 'LOGNAME': 'cltbld', 05:23:53 INFO - 'MAIL': '/var/mail/cltbld', 05:23:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:53 INFO - 'MOZ_NO_REMOTE': '1', 05:23:53 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:53 INFO - 'NO_EM_RESTART': '1', 05:23:53 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:53 INFO - 'PWD': '/builds/slave/test', 05:23:53 INFO - 'SHELL': '/bin/bash', 05:23:53 INFO - 'SHLVL': '1', 05:23:53 INFO - 'TERM': 'linux', 05:23:53 INFO - 'TMOUT': '86400', 05:23:53 INFO - 'USER': 'cltbld', 05:23:53 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:23:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:53 INFO - '_': '/tools/buildbot/bin/python'} 05:23:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:54 INFO - Downloading/unpacking psutil>=0.7.1 05:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:54 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:54 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:54 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:54 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:55 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:23:55 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:23:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:23:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:55 INFO - Installing collected packages: psutil 05:23:55 INFO - Running setup.py install for psutil 05:23:55 INFO - building 'psutil._psutil_linux' extension 05:23:55 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 05:23:56 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 05:23:56 INFO - building 'psutil._psutil_posix' extension 05:23:56 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 05:23:56 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 05:23:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:23:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:23:56 INFO - Successfully installed psutil 05:23:56 INFO - Cleaning up... 05:23:56 INFO - Return code: 0 05:23:56 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:56 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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:23:56 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 05:23:56 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 05:23:56 INFO - Using env: {'DISPLAY': ':0', 05:23:56 INFO - 'HOME': '/home/cltbld', 05:23:56 INFO - 'LANG': 'en_US.UTF-8', 05:23:56 INFO - 'LANGUAGE': 'en_US:en', 05:23:56 INFO - 'LOGNAME': 'cltbld', 05:23:56 INFO - 'MAIL': '/var/mail/cltbld', 05:23:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:56 INFO - 'MOZ_NO_REMOTE': '1', 05:23:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:56 INFO - 'NO_EM_RESTART': '1', 05:23:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:56 INFO - 'PWD': '/builds/slave/test', 05:23:56 INFO - 'SHELL': '/bin/bash', 05:23:56 INFO - 'SHLVL': '1', 05:23:56 INFO - 'TERM': 'linux', 05:23:56 INFO - 'TMOUT': '86400', 05:23:56 INFO - 'USER': 'cltbld', 05:23:56 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:23:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:56 INFO - '_': '/tools/buildbot/bin/python'} 05:23:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:56 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:23:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:23:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:23:58 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:23:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:23:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:23:58 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:23:58 INFO - Installing collected packages: mozsystemmonitor 05:23:58 INFO - Running setup.py install for mozsystemmonitor 05:23:58 INFO - Successfully installed mozsystemmonitor 05:23:58 INFO - Cleaning up... 05:23:58 INFO - Return code: 0 05:23:58 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:23:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:23:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:23:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:23:58 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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:23:58 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 05:23:58 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 05:23:58 INFO - Using env: {'DISPLAY': ':0', 05:23:58 INFO - 'HOME': '/home/cltbld', 05:23:58 INFO - 'LANG': 'en_US.UTF-8', 05:23:58 INFO - 'LANGUAGE': 'en_US:en', 05:23:58 INFO - 'LOGNAME': 'cltbld', 05:23:58 INFO - 'MAIL': '/var/mail/cltbld', 05:23:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:23:58 INFO - 'MOZ_NO_REMOTE': '1', 05:23:58 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:23:58 INFO - 'NO_EM_RESTART': '1', 05:23:58 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:23:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:23:58 INFO - 'PWD': '/builds/slave/test', 05:23:58 INFO - 'SHELL': '/bin/bash', 05:23:58 INFO - 'SHLVL': '1', 05:23:58 INFO - 'TERM': 'linux', 05:23:58 INFO - 'TMOUT': '86400', 05:23:58 INFO - 'USER': 'cltbld', 05:23:58 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:23:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:23:58 INFO - '_': '/tools/buildbot/bin/python'} 05:23:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:23:58 INFO - Downloading/unpacking blobuploader==1.2.4 05:23:58 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 05:23:58 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 05:23:58 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 05:23:58 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 05:23:58 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 05:23:58 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 05:24:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:24:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:24:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:24:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:24:01 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:24:01 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 05:24:01 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 05:24:01 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 05:24:01 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 05:24:01 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 05:24:01 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 05:24:01 INFO - Downloading docopt-0.6.1.tar.gz 05:24:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:24:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:24:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:24:01 INFO - Running setup.py install for blobuploader 05:24:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:24:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:24:01 INFO - Running setup.py install for requests 05:24:01 INFO - Running setup.py install for docopt 05:24:01 INFO - Successfully installed blobuploader requests docopt 05:24:01 INFO - Cleaning up... 05:24:01 INFO - Return code: 0 05:24:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:01 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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:24:01 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 05:24:01 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 05:24:01 INFO - Using env: {'DISPLAY': ':0', 05:24:01 INFO - 'HOME': '/home/cltbld', 05:24:01 INFO - 'LANG': 'en_US.UTF-8', 05:24:01 INFO - 'LANGUAGE': 'en_US:en', 05:24:01 INFO - 'LOGNAME': 'cltbld', 05:24:01 INFO - 'MAIL': '/var/mail/cltbld', 05:24:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:01 INFO - 'MOZ_NO_REMOTE': '1', 05:24:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:01 INFO - 'NO_EM_RESTART': '1', 05:24:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:01 INFO - 'PWD': '/builds/slave/test', 05:24:01 INFO - 'SHELL': '/bin/bash', 05:24:01 INFO - 'SHLVL': '1', 05:24:01 INFO - 'TERM': 'linux', 05:24:01 INFO - 'TMOUT': '86400', 05:24:01 INFO - 'USER': 'cltbld', 05:24:01 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:24:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:01 INFO - '_': '/tools/buildbot/bin/python'} 05:24:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:02 INFO - Running setup.py (path:/tmp/pip-QJCExY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:02 INFO - Running setup.py (path:/tmp/pip-wSEkgR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:02 INFO - Running setup.py (path:/tmp/pip-9GjBdL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:02 INFO - Running setup.py (path:/tmp/pip-LOaVFY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:02 INFO - Running setup.py (path:/tmp/pip-spWQmR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:02 INFO - Running setup.py (path:/tmp/pip-5Jtsvj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:02 INFO - Running setup.py (path:/tmp/pip-q81BBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:02 INFO - Running setup.py (path:/tmp/pip-M7EAX_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:02 INFO - Running setup.py (path:/tmp/pip-B5Brg8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:02 INFO - Running setup.py (path:/tmp/pip-HqUfFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:02 INFO - Running setup.py (path:/tmp/pip-JjTpDL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:02 INFO - Running setup.py (path:/tmp/pip-XJKqpQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:02 INFO - Running setup.py (path:/tmp/pip-qS82KA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:03 INFO - Running setup.py (path:/tmp/pip-yqcdPm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:03 INFO - Running setup.py (path:/tmp/pip-HVrl2c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:03 INFO - Running setup.py (path:/tmp/pip-T1TS3P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:03 INFO - Running setup.py (path:/tmp/pip-v2nPUt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:03 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:24:03 INFO - Running setup.py install for manifestparser 05:24:03 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:24:03 INFO - Running setup.py install for mozcrash 05:24:03 INFO - Running setup.py install for mozdebug 05:24:03 INFO - Running setup.py install for mozdevice 05:24:03 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:24:03 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:24:03 INFO - Running setup.py install for mozfile 05:24:03 INFO - Running setup.py install for mozhttpd 05:24:03 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:24:03 INFO - Running setup.py install for mozinfo 05:24:04 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for mozInstall 05:24:04 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for mozleak 05:24:04 INFO - Running setup.py install for mozlog 05:24:04 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for moznetwork 05:24:04 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for mozprocess 05:24:04 INFO - Running setup.py install for mozprofile 05:24:04 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for mozrunner 05:24:04 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:24:04 INFO - Running setup.py install for mozscreenshot 05:24:04 INFO - Running setup.py install for moztest 05:24:04 INFO - Running setup.py install for mozversion 05:24:05 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:24:05 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:24:05 INFO - Cleaning up... 05:24:05 INFO - Return code: 0 05:24:05 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:24:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:05 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:24:05 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 05:24:05 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 05:24:05 INFO - Using env: {'DISPLAY': ':0', 05:24:05 INFO - 'HOME': '/home/cltbld', 05:24:05 INFO - 'LANG': 'en_US.UTF-8', 05:24:05 INFO - 'LANGUAGE': 'en_US:en', 05:24:05 INFO - 'LOGNAME': 'cltbld', 05:24:05 INFO - 'MAIL': '/var/mail/cltbld', 05:24:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:05 INFO - 'MOZ_NO_REMOTE': '1', 05:24:05 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:05 INFO - 'NO_EM_RESTART': '1', 05:24:05 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:05 INFO - 'PWD': '/builds/slave/test', 05:24:05 INFO - 'SHELL': '/bin/bash', 05:24:05 INFO - 'SHLVL': '1', 05:24:05 INFO - 'TERM': 'linux', 05:24:05 INFO - 'TMOUT': '86400', 05:24:05 INFO - 'USER': 'cltbld', 05:24:05 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:24:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:05 INFO - '_': '/tools/buildbot/bin/python'} 05:24:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:24:05 INFO - Running setup.py (path:/tmp/pip-nmOsNZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:24:05 INFO - Running setup.py (path:/tmp/pip-CVbo9U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:24:05 INFO - Running setup.py (path:/tmp/pip-kntOB_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:24:05 INFO - Running setup.py (path:/tmp/pip-UqNmew-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:24:05 INFO - Running setup.py (path:/tmp/pip-Njib_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:24:05 INFO - Running setup.py (path:/tmp/pip-Gygz2i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:24:05 INFO - Running setup.py (path:/tmp/pip-YpG08w-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:24:05 INFO - Running setup.py (path:/tmp/pip-GzgqJJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:24:05 INFO - Running setup.py (path:/tmp/pip-zSJK54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:24:05 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)) 05:24:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:24:05 INFO - Running setup.py (path:/tmp/pip-xLfWEz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:24:06 INFO - Running setup.py (path:/tmp/pip-HDginm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:24:06 INFO - Running setup.py (path:/tmp/pip-ktfAAQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:24:06 INFO - Running setup.py (path:/tmp/pip-at8cb4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:24:06 INFO - Running setup.py (path:/tmp/pip-EHIfAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:06 INFO - Running setup.py (path:/tmp/pip-wkGiLL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:24:06 INFO - Running setup.py (path:/tmp/pip-NDalgM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:24:06 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)) 05:24:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:24:06 INFO - Running setup.py (path:/tmp/pip-g5TuGl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:24:06 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)) 05:24:06 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)) 05:24:06 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)) 05:24:06 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)) 05:24:06 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)) 05:24:06 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)) 05:24:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:24:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:24:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:24:08 INFO - Downloading blessings-1.5.1.tar.gz 05:24:08 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 05:24:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:24:08 INFO - Installing collected packages: blessings 05:24:08 INFO - Running setup.py install for blessings 05:24:08 INFO - Successfully installed blessings 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:08 INFO - Reading from file tmpfile_stdout 05:24:08 INFO - Current package versions: 05:24:08 INFO - argparse == 1.2.1 05:24:08 INFO - blessings == 1.5.1 05:24:08 INFO - blobuploader == 1.2.4 05:24:08 INFO - docopt == 0.6.1 05:24:08 INFO - manifestparser == 1.1 05:24:08 INFO - mozInstall == 1.12 05:24:08 INFO - mozcrash == 0.16 05:24:08 INFO - mozdebug == 0.1 05:24:08 INFO - mozdevice == 0.47 05:24:08 INFO - mozfile == 1.2 05:24:08 INFO - mozhttpd == 0.7 05:24:08 INFO - mozinfo == 0.9 05:24:08 INFO - mozleak == 0.1 05:24:08 INFO - mozlog == 3.0 05:24:08 INFO - moznetwork == 0.27 05:24:08 INFO - mozprocess == 0.22 05:24:08 INFO - mozprofile == 0.27 05:24:08 INFO - mozrunner == 6.11 05:24:08 INFO - mozscreenshot == 0.1 05:24:08 INFO - mozsystemmonitor == 0.0 05:24:08 INFO - moztest == 0.7 05:24:08 INFO - mozversion == 1.4 05:24:08 INFO - psutil == 3.1.1 05:24:08 INFO - requests == 1.2.3 05:24:08 INFO - wsgiref == 0.1.2 05:24:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:24: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')]} 05:24:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24: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')]} 05:24:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:24:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:24:08 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 0x7ff231ba8c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1b756c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1c26900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, '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': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', '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 05:24:08 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 05:24:08 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 05:24:08 INFO - Using env: {'DISPLAY': ':0', 05:24:08 INFO - 'HOME': '/home/cltbld', 05:24:08 INFO - 'LANG': 'en_US.UTF-8', 05:24:08 INFO - 'LANGUAGE': 'en_US:en', 05:24:08 INFO - 'LOGNAME': 'cltbld', 05:24:08 INFO - 'MAIL': '/var/mail/cltbld', 05:24:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:08 INFO - 'MOZ_NO_REMOTE': '1', 05:24:08 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:08 INFO - 'NO_EM_RESTART': '1', 05:24:08 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:08 INFO - 'PWD': '/builds/slave/test', 05:24:08 INFO - 'SHELL': '/bin/bash', 05:24:08 INFO - 'SHLVL': '1', 05:24:08 INFO - 'TERM': 'linux', 05:24:08 INFO - 'TMOUT': '86400', 05:24:08 INFO - 'USER': 'cltbld', 05:24:08 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:24:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:08 INFO - '_': '/tools/buildbot/bin/python'} 05:24:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 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)) 05:24:08 INFO - Cleaning up... 05:24:08 INFO - Return code: 0 05:24:08 INFO - Running post-action listener: _resource_record_post_action 05:24:08 INFO - Running post-action listener: _start_resource_monitoring 05:24:08 INFO - Starting resource monitoring. 05:24:08 INFO - ##### 05:24:08 INFO - ##### Running install step. 05:24:08 INFO - ##### 05:24:08 INFO - Running pre-action listener: _resource_record_pre_action 05:24:08 INFO - Running main action method: install 05:24:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:24:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:24:09 INFO - Reading from file tmpfile_stdout 05:24:09 INFO - Detecting whether we're running mozinstall >=1.0... 05:24:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:24:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:24:09 INFO - Reading from file tmpfile_stdout 05:24:09 INFO - Output received: 05:24:09 INFO - Usage: mozinstall [options] installer 05:24:09 INFO - Options: 05:24:09 INFO - -h, --help show this help message and exit 05:24:09 INFO - -d DEST, --destination=DEST 05:24:09 INFO - Directory to install application into. [default: 05:24:09 INFO - "/builds/slave/test"] 05:24:09 INFO - --app=APP Application being installed. [default: firefox] 05:24:09 INFO - mkdir: /builds/slave/test/build/application 05:24:09 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'] 05:24:09 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 05:24:23 INFO - Reading from file tmpfile_stdout 05:24:23 INFO - Output received: 05:24:23 INFO - /builds/slave/test/build/application/firefox/firefox 05:24:23 INFO - Running post-action listener: _resource_record_post_action 05:24:23 INFO - ##### 05:24:23 INFO - ##### Running run-tests step. 05:24:23 INFO - ##### 05:24:23 INFO - Running pre-action listener: _resource_record_pre_action 05:24:23 INFO - Running main action method: run_tests 05:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:24:23 INFO - Python 2.7.3 05:24:23 INFO - Return code: 0 05:24:23 INFO - grabbing minidump binary from tooltool 05:24:23 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')]} 05:24:23 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 0x1c6cb70>, '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 0x1cbddc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1cbe250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:24:23 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 05:24:23 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 05:24:23 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:24:23 INFO - Return code: 0 05:24:23 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 05:24:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:24:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:24:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 05:24:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:24:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] in /builds/slave/test/build 05:24:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox-Non-PGO --suite dromaeojs --executablePath /builds/slave/test/build/application/firefox/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-042 --webServer localhost 05:24:23 INFO - Using env: {'DISPLAY': ':0', 05:24:23 INFO - 'HOME': '/home/cltbld', 05:24:23 INFO - 'LANG': 'en_US.UTF-8', 05:24:23 INFO - 'LANGUAGE': 'en_US:en', 05:24:23 INFO - 'LOGNAME': 'cltbld', 05:24:23 INFO - 'MAIL': '/var/mail/cltbld', 05:24:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:24:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 05:24:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:24:23 INFO - 'MOZ_NO_REMOTE': '1', 05:24:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:24:23 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 05:24:23 INFO - 'NO_EM_RESTART': '1', 05:24:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 05:24:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:24:23 INFO - 'PWD': '/builds/slave/test', 05:24:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:24:23 INFO - 'SHELL': '/bin/bash', 05:24:23 INFO - 'SHLVL': '1', 05:24:23 INFO - 'TERM': 'linux', 05:24:23 INFO - 'TMOUT': '86400', 05:24:23 INFO - 'USER': 'cltbld', 05:24:23 INFO - 'XDG_SESSION_COOKIE': 'c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244', 05:24:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:24:23 INFO - '_': '/tools/buildbot/bin/python'} 05:24:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox-Non-PGO', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/firefox/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-042', '--webServer', 'localhost'] with output_timeout 3600 05:24:23 INFO - mozversion INFO | application_buildid: 20151120041233 05:24:23 INFO - mozversion INFO | application_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 05:24:23 INFO - mozversion INFO | application_display_name: Nightly 05:24:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:24:23 INFO - mozversion INFO | application_name: Firefox 05:24:23 INFO - mozversion INFO | application_remotingname: firefox 05:24:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:24:23 INFO - mozversion INFO | application_vendor: Mozilla 05:24:23 INFO - mozversion INFO | application_version: 45.0a1 05:24:23 INFO - mozversion INFO | platform_buildid: 20151120041233 05:24:23 INFO - mozversion INFO | platform_changeset: 1b2e15608f34fef0f23369731c80138f55f00cf2 05:24:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:24:23 INFO - mozversion INFO | platform_version: 45.0a1 05:24:23 INFO - 2015-11-20 05:24:23,863 DEBUG : using testdate: 1448025863 05:24:23 INFO - 2015-11-20 05:24:23,863 DEBUG : actual date: 1448025863 05:24:23 INFO - 2015-11-20 05:24:23,870 INFO : starting webserver on 'localhost:51496' 05:24:23 INFO - 2015-11-20 05:24:23,871 INFO : Starting test suite talos-linux64-ix-042 05:24:23 INFO - 2015-11-20 05:24:23,871 INFO : Starting test dromaeo_css 05:24:23 INFO - 2015-11-20 05:24:23,871 DEBUG : operating with platform_type : linux_ 05:24:23 INFO - 2015-11-20 05:24:23,872 INFO : Initialising browser for dromaeo_css test... 05:24:23 INFO - 2015-11-20 05:24:23,878 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61DUio/profile http://localhost:51496/getInfo.html 05:24:29 INFO - 2015-11-20 05:24:29,375 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:24:29 INFO - 2015-11-20 05:24:29,376 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:24:29 INFO - 2015-11-20 05:24:29,376 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:24:29 INFO - 2015-11-20 05:24:29,376 DEBUG : BROWSER_OUTPUT: __metrics 05:24:29 INFO - 2015-11-20 05:24:29,484 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:24:30 INFO - 2015-11-20 05:24:30,883 INFO : Browser initialized. 05:24:30 INFO - 2015-11-20 05:24:30,884 INFO : Running cycle 1/1 for dromaeo_css test... 05:24:30 INFO - 2015-11-20 05:24:30,884 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp61DUio/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:24:42 INFO - 2015-11-20 05:24:42,800 DEBUG : BROWSER_OUTPUT: RSS: Main: 141492224 05:24:42 INFO - 2015-11-20 05:24:42,800 DEBUG : BROWSER_OUTPUT: 05:25:34 INFO - 2015-11-20 05:25:34,245 DEBUG : BROWSER_OUTPUT: 1448025934241 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] 05:27:46 INFO - 2015-11-20 05:27:46,562 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51496/tests/dromaeo/cssquery-ext.html) 05:27:47 INFO - 2015-11-20 05:27:47,652 DEBUG : BROWSER_OUTPUT: RSS: Main: 242442240 05:27:47 INFO - 2015-11-20 05:27:47,652 DEBUG : BROWSER_OUTPUT: 05:30:50 INFO - 2015-11-20 05:30:50,130 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-ext.html (next: http://localhost:51496/tests/dromaeo/cssquery-jquery.html) 05:30:50 INFO - 2015-11-20 05:30:50,703 DEBUG : BROWSER_OUTPUT: RSS: Main: 212283392 05:30:50 INFO - 2015-11-20 05:30:50,704 DEBUG : BROWSER_OUTPUT: 05:33:52 INFO - 2015-11-20 05:33:52,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51496/tests/dromaeo/cssquery-mootools.html) 05:33:53 INFO - 2015-11-20 05:33:53,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 212672512 05:33:53 INFO - 2015-11-20 05:33:53,432 DEBUG : BROWSER_OUTPUT: 05:36:55 INFO - 2015-11-20 05:36:55,359 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51496/tests/dromaeo/cssquery-prototype.html) 05:36:55 INFO - 2015-11-20 05:36:55,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 197980160 05:36:55 INFO - 2015-11-20 05:36:55,941 DEBUG : BROWSER_OUTPUT: 05:39:58 INFO - 2015-11-20 05:39:58,708 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51496/tests/dromaeo/cssquery-yui.html) 05:39:59 INFO - 2015-11-20 05:39:59,293 DEBUG : BROWSER_OUTPUT: RSS: Main: 202412032 05:39:59 INFO - 2015-11-20 05:39:59,293 DEBUG : BROWSER_OUTPUT: 05:43:01 INFO - 2015-11-20 05:43:01,880 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/dromaeo/cssquery-yui.html (next: http://localhost:51496/tests/dromaeo/cssquery-dojo.html) 05:43:02 INFO - 2015-11-20 05:43:02,130 DEBUG : BROWSER_OUTPUT: RSS: Main: 249081856 05:43:02 INFO - 2015-11-20 05:43:02,130 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,130 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:43:02 INFO - 2015-11-20 05:43:02,130 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:43:02 INFO - 2015-11-20 05:43:02,131 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:43:02 INFO - 2015-11-20 05:43:02,131 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:43:02 INFO - 2015-11-20 05:43:02,132 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2663.5205662980666;2768.4878297514947;2771.8475483848392;2790.595363672266;2807.2420446479446;4638.072385522892;4678.438587369516;4782.450018247902;4791.425028996521;4794.280857871321;4769.141554520185;4821.855344339676;4856.198727210006;4859.368282123328;4943.332650092237;4211.275941546421;4452.131834292314;4460.933086003713;4483.170613436509;4500.5499450054895;4212.705110642256;4508.932366014513;4531.139083574127;4564.178447879381;4579.519150489201;4338.370936214263;4386.122775444892;4392.956070439319;4396.230659634567;4410.184115938561;4350.963093443206;4369.781510924441;4372.672049596293;4423.690341676084;4447.021655235843;4271.722338048017;4428.22506061438;4429.623482004034;4446.866594002185;4481.641468682497;4694.765261736899;4715.693479923828;4727.692699974525;4797.904041919142;4863.343448634424;5146.7683954221775;5148.433672296044;5150.716710580917;5161.406438259611;5194.402643695986;4936.5063493650705;5175.378954525443;5176.50823171798;5186.948130518685;5199.922001169985;4660.6970546914345;4683.461401938786;4693.272542755878;4725.5983241424865;4751.928721069186;5287.23335116406;5347.866303342447;5357.303550538405;5359.839204823861;5360.437154098841;5098.286239926413;5126.102931986888;5133.435322114565;5143.099957507421;5189.3253876996505;4933.358663373739;4933.9013219736125;5030.8239211627415;5036.924446133311;5040.521150490697;5114.897702045938;5115.948840511547;5120.80170660321;5122.282880396748;5128.435872054071;5089.541941225233;5094.49055094495;5097.311862898536;5099.056674515226;5158.74206289684;4083.97958010214;4124.91750164995;4156.750594964312;4182.247195504778;4264.936025959613;3769.509963704701;3773.735838491279;3792.981035094807;3808.5429748430365;3819.7708137511836;4431.556844315543;4433.512313645497;4438.267685831866;4465.553444655508;4472.306792447176;4939.703617782944;5048.368953880765;5054.646174767731;5055.317532133188;5205.167173252337;4269.7224680395675;4334.43652325202;4336.891577710582;4358.455193100863;4362.476502819682;4536;4585.679002469795;4592.977035114803;4594.6783725139585;4638.397008388888;4647.65142614312;4782.521747825329;4937.308776771255;4946.03552307311;4948.406191257072;5144.176931690911;5155.510226528474;5220.190870415092;5240.187770895517;5282.498162674539;4872.317875497504;4875.390576177978;4903.534164254533;4915.852524424273;4921.040397122527;4817.638677099161;4918.92621610669;5076;5078.314427552381;5084.491550844886;4915.508449155056;5000.824971125993;5055.797768089235;5072.213806859942;5113.769880355468;5039.294498770102;5052.267421223975;5052.8484145475695;5060.367454068241;5104.310918026019;5045.6720313180995;5051.646384753179;5058.291839142449;5065.797368105382;5067.5185857343495;4743.644226683082;4797.496262892346;4849.393825771778;4921.13880070979;4942.233953737176;4970.701757894538;4999.375078115236;5063.240513922941;5091.134507133722;5095.668781529189;4930.778114984762;4956.925646115239;4963.305137280856;4969.552740253394;5004.1492946198505 05:43:02 INFO - 2015-11-20 05:43:02,133 DEBUG : BROWSER_OUTPUT: |1;ext.html;546.1496450027306;562.2269379603046;575.5194412665425;586.5776640818609;596.8331911113773;27668.86165569172;36152.819235903815;36839.44740828886;36885.44671829918;36899.26201475969;40516.39225411614;41227.79386103065;41247.58752412475;41258.381124283085;41398;7067.469939754514;7189.640517974107;8003.679852805895;8170.550619715913;9889.25830562707;10160.695179144637;10279.280450368477;10283.691489255334;10285.897141028569;10293.53679084443;10190.6942791716;10300.536475858604;10302.433366164858;10302.690919272434;10310.278280520366;7297.197308296083;7486.401087912981;10243.334183278137;10509.632162874263;10510.31682940614;9930.106290433896;10059.748506287327;10064.043915827984;10066;10070.395776253448;37971.24057518834;38459.80770096132;38721.22557548833;38735.225295494216;38763.22473550513;2936.07513633207;2938.6326709161353;2947.071672423201;3118.3607360491046;3367.44437167867;28919.56620650692;29276.560851587245;29329;29420.70579294201;29798;3312.4285367797306;3349.949750753716;3362.613299470543;3367.71374433171;3476.4090104682014;224690;225557;226113;226126.99999999834;226162;54517.1822422664;54819;54825.177622335694;54897.725511372984;54927.450725492236;48829.755851220514;49654.25518617224;63021.68489157525;64059.67970160119;64513.35486645073;14880.107193568421;15014.24928753558;15103.4713785017;15122.470713524974;15134.394624214909;10375.481225938824;10401.68794936153;10410.895891041144;10424.113950314157;10434.739131521621;18527.444176674722;18619.720704189447;18639.627207456047;18772.436826895217;18776.248950041845;7486.577550265432;7635.083789945242;7694.384449244047;7741.574213418204;7797.259260370256;826.9875951860727;854.6581367452944;894.9776255593662;1050.5850189175385;1070.272214893864;26491.602625960626;26643.866780665972;26812.865935670197;26855.328616784347;27892.860535697597;887.4941283468361;947.4978261521404;964.0504103458088;965.1169180200038;973.1193270090579;12220.266783992989;12321.137520373488;12459.750804983849;12515.56195533152;12530.436130374155;257515;258367;261187;262136;262613;45361.54638453639;45606;45668.77165614151;45682.54317456783;45683.77158114188;1161.9477123529462;1172.1619042384907;1194.6236935365332;1240.9823944365714;1259.200407741091;22883.31350059501;23809.214892735858;24036.63945040861;25711;26157.607635885095;41115;41585.58414415938;41613;41648;41676.79161604172;216937;218417;218625;218877;219012;24673.50652986966;25162;28372.148835534143;28928.132156035354;29347.55978660279;34085.82957085199;34353.65646343504;38550.2289954205;39240.215195696495;39341.40987885241;32683.673163268064;32913.83543082269;33032.66967330296;33120;33633;33014.17464563405;33151.861461472545;33306.666933331326;33312.83343583267;33377.49933750947;32922.50616240806;33412.49881251735;33413;33635;33895.491567626996;27510.724892751616;28457.28856778597;29908.401831963674;30455.390892182477;30458.54312185275;23053.423664407852;23101.65347519822;23114.306570802903;23158.652620211047;23371 05:43:02 INFO - 2015-11-20 05:43:02,137 DEBUG : BROWSER_OUTPUT: |2;jquery.html;326.1243561038613;330.0593309069152;330.2519792669603;333.1604357020309;343.5844321395849;12598.370081495934;12891.226526408398;14801;15236.085834849902;15382.153981531012;12716.173448725825;14811.407543698266;14930.328135233913;15132.394704211818;15143.24283785809;4645.55867192617;4801.711897286156;4868.026394721052;4994.850154495371;5000.07498612756;3579.67782899539;3656.433252845813;4985.526374994388;5028.396592408898;5298.92051619226;5670.574706896979;5682.886342273152;5703.914441283384;5728.828135155952;5731.1116776899435;5422.48486393792;5561.63849349793;5660.150977353389;5661.886762264773;5662.716864156796;4898.5591296783105;4904.6321525885705;4905.2887331337115;4906.803727850882;4931.802727890916;18623.348182813537;18850.245990160376;18977;18981.24075036997;19676;1886.0852486544015;1918.673825449677;1944.7957964413674;2020.2928974858828;2022.4033909996585;12461.813072803916;12598.937005315007;12685;12714.237145771283;13072.803907941388;1770.5927636643644;1786.2497750944635;1792.1755992243584;1794.5693033671826;1810.1582764014797;47409.65150401693;53207.20189197165;54939;55400.445995540336;55632;9149.496777677292;9431.434113953184;9583.856242156373;9620.182284505756;9659.951700241454;12144.392780360946;12159.088068394905;12302.507899683913;12343.321117338633;12373.566925157576;7115;7120.537165084253;7167;7229.132504099436;7280.053593032978;6860.656967151623;6912.965435172792;7066.6819993100435;7160.033395491646;7175.964120179366;4168.103857670615;4245.830166793356;4280.443542339538;4307.483102027714;4333.371661109121;1513.6291608555755;1631.6818220447137;1677.7231756760243;1707.4109432245855;1734.3669560610285;903.0923921458892;956.6125719083782;972.557486343712;989.6684610655367;1002.9598816047277;15725.370985160695;15972.920135399481;16359.83640163607;16371;16423.753643695352;720.2749415150789;799.7520768561648;803;847.8897743293332;905.2350763604743;8877.600507977157;8899;8943.329250306122;9119.544022798833;9180.265578753684;445945;451447;457736.7113164413;466018;466955;71510;72443.6377818118;72993.63503182556;73158;73401;1015.2994433840627;1023.744063984004;1031.1132426113536;1033.3180101133216;1038.1072277841201;13580.45678172862;14131.717365652425;14203.431862725376;14278.286085695881;14349.497767578503;29084.418311634072;29188.708112918597;30060.398792024476;30177.54733678953;30259.394812103194;38402.807985959895;45358.546414535434;45919.77040114778;46762.532374677176;47900.520994791;8711.91288087111;8924.375293729376;8944.597493112955;9040.186383225542;9050;10833.67498975032;15355.385784568938;15966.60083497922;16237.675246494768;16296.918515407348;12611.432485538357;13025.283609401575;13251.66870828237;13911.582652520441;14049.859501405264;12775.936120319338;12973.09188356806;13643.658908527366;14125.858741412454;14251.64370890736;10893.311536711823;11450.427478625868;13510.93244533771;13722.519711810039;13875.236861972284;7837.333826624573;9213.861792073258;9349.719508414759;9375.765605859635;9397;9946.403215807075;11987.520499180284;13906.58280251594;14154.363053662404;14375.28123593837 05:43:02 INFO - 2015-11-20 05:43:02,137 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1424.9287535623216;1670.8329167083293;1714.9314027438902;1726.1283052058711;1744.4330592557421;6401.679916004198;6870.38166565009;7027.578345299273;7037.612931288777;7058.858822823547;7226.7831965041005;7316.524425912312;7327.0841144856895;7330.120385553728;7349;2118.533922537043;2139.5506943541873;2142.528643698384;2142.78572142786;2143.839212059102;2132.626790311697;2167.9132834686593;2209.304069218191;2217.678436626696;2229.7658745831695;2111.345482900298;2145.0776166248506;2151.365347222565;2162.4485756132162;2164.0694501364405;2101.7582977957577;2113.2286715348864;2129.4144110369693;2131.488442773731;2131.6589345704615;2129.563439494915;2156.6549352103743;2174.1738139507042;2175.4126385875725;2184.595849767798;5918.822435326947;6059.363766804466;7226.891596626055;7264.4914855960105;7264.600446975414;3842.1163132479405;3933.2723446162267;4275.764832934187;4400.44994375703;4424.048829501673;2873.4971380008624;2912.126362091364;2953.4683756923746;2957.31981644223;3002.4145291668133;887.130612000237;908.6501696846695;920.3603495570514;927.0219917986522;940.7883226274033;9904.653337133166;9934.354266972696;9948.353357031841;9957.302988790787;9967.601295948081;4114.526829414655;4189.120284740177;4222.59885310895;4241.024564350217;4252.808623611945;8623.78440538979;8626.309895208367;8653;8657.134286571292;8666.133386661284;4568.794404251817;4570.9314360284625;4571.3600095986585;4572.679912406166;4577.908441831145;4095.0581366285323;4095.5904409559403;4101.05675694586;4105.220008198433;4106.3635136553885;3308.2887179256577;3317.1872891141343;3329.8501567429525;3332.3501917125927;3347.916302092467;1101.9944900275448;1128.306091753582;1136.4715407335464;1142.3264916896785;1143.9942800286112;1151.9942400287946;1167.6380322100006;1173.9530418783154;1177.591824718453;1193.9880601193877;6967.163940327092;7016.543924644881;7074.327938845801;7076.575405475688;7091.574505529685;467.1031619290969;472.49443095887756;473.5453964194343;475.44135640622824;479.83685546914217;4785.282207668808;5319.521243088063;5417.079096553595;5426.430224826416;5427.83716488506;7715.498492598075;8460.111688272766;8535.420947124801;8610.268127209132;8630.093840146694;8348.206920342558;8352.540610266373;8525.872111918326;8542.18849209324;8546.61540230691;6585.967070164618;6667.366600172976;6669.533132680763;6670.566413183127;6686.99695045747;6218.315985241529;6227.314995350417;6238.313785483502;6265.310815810166;6270.372962703693;7159.319864612853;7349.154847192427;7376.7786966391095;7384.815379615553;7402.814929626802;7521.661525231487;7799.6100194988885;7861.135275119618;7907.327877130509;7933.9603301983125;5917.1715959766525;5954.672493012926;5997.880042399041;6003.3996600339615;6006.009008513546;6836.077129587442;6870.7595234166565;6881.965590172017;6906.067680863019;6907.13660792401;6182.289036760651;6191.442770150708;6362.554621176473;6426.485881129592;6444.13004244421;6166.260048794174;6236.937630623635;6246.593971391845;6248.875022499434;6447.967760161169;6578.0790689304495;6611.900821487586;6626.337366263335;6638.17022872141;6644.103046088716;6057;6080.422359875804;6092.147099405998;6097.298810636834;6102.267727872683;5852.7658893643775;6058.787942421994;6063.878722425438;6071.119687645179;6071.939280607314 05:43:02 INFO - 2015-11-20 05:43:02,138 DEBUG : BROWSER_OUTPUT: |4;prototype.html;303.9133846853647;308.3601526831824;313.5876322635733;314.87090292979883;322.41481710695103;5273.551748101411;5478.287822583064;5483.643563168402;5524.254225679537;5542.63972841766;5356.9732151339185;5430.619856610039;5439.782408703657;5440.646357986728;5452.291202143716;3941.27086488999;4012.9799351003203;4021.4369988201674;4194.475690538683;4233.491980962289;4155.106652069804;4172.290710579194;4177.373393990911;4182.079942412664;4187.664986801049;4123.567025462328;4126.979365103185;4127.09203975125;4134.090500089976;4134.697570265372;3931.547871994714;4037.454943582608;4046.676265898721;4138.296489596776;4160.271952408347;3598.24436868258;3603.0632035670915;3603.3694103531775;3604.3692353838237;3612.5123108380294;5189.42916279209;5189.481051894818;5192.766325515323;5202.037623039712;5205.479452054802;4740.241561350202;4758.286257061469;4761;4763.214069678499;4771.71369717818;5502.064649009678;5661.5187709044785;5683.488486036276;5693.316801983747;5703.17303990919;3969.0474286171398;3975.1453437511072;3975.6024397560013;3975.6223158799867;3977.204559088194;5882.205902203191;5963.5527335450015;5965.164876917279;5975.940240597625;5977.22296101504;4062.289099407592;4085.7344272622186;4100.958990410118;4106.384042393605;4108.876733697994;4006.2988976928923;4152.792360381969;4170.145120250341;4170.374443833449;4176.644985176234;4772.7136371817105;4785.234362501983;4790.640701947298;4795.184818580849;4796.040791841646;5724.914126288109;5735.168400581976;5735.225744524436;5737.340205876294;5748.13777933305;1450.9564713058626;1473.2633683158422;1475.6089636246188;1476.3061361160237;1478.1648368671665;975.7267964969819;984.6110786239395;990.8860481044628;992.9156021738233;1004.5981607357115;4885.2427873679635;4887.926681099786;4899.314096026559;4901.3383193269165;4901.926471102936;5815.912761308584;5819.214406055213;5820.88358232833;5824.592278540546;5825.563082768809;4882.023595280958;4887.120318342732;4888.266759986031;4896.779644915988;4904.60763138948;2944.484715174836;3053.2366908272934;3121.71904528589;3137.30979184579;3147.7009684080435;5568.220449137124;5609.467100625434;5643.435656434406;5654.858628534237;5656.2929633795775;6117.755289788448;6123.234595675541;6129.724162412702;6133.355997620275;6134.38656134383;5617.269754931833;5630.324361076615;5636.718164091861;5643.492085712305;5649.745761440745;5775.740091695968;5897.439743224387;5916.881662366814;5920.141579471038;5926.911096333472;5825.50483208932;5836.328822185503;5837.0368889132815;5837.503812176013;5837.854053648693;5625.943740562542;5630.887382252414;5631.380548139619;5631.929933312657;5639.492445679908;4010.318245898146;4093.7748423836974;4100.774457404871;4107.774072425926;4115;5906.586538942404;5908.172855800278;5921.644701317935;5922.1412895130825;5923.08192230205;5661.037623603915;5688.5733569981585;5691.430856914276;5693.601447898607;5697.829065128053;5568.610197286151;5648.491635752802;5676.886462270814;5681.2330335404195;5701.458361455655;5570.721463926707;5573.6098473106495;5576.052071147834;5577.386487486455;5579.6652200868075;5731.398203188605;5731.885362292647;5734.598578099493;5735.197072409949;5738.741756620879;5310.389305229948;5412.864678383072;5490.972545137249;5594.496495315441;5595.496405323541 05:43:02 INFO - 2015-11-20 05:43:02,139 DEBUG : BROWSER_OUTPUT: |5;yui.html;773.8374941262331;777.1102088109113;778.7040924448712;780.402991711341;796.1918652567641;12164.81752773708;12487.251784750142;12489.188202766814;12507.312097834616;12511.18677285977;11960.461779219935;12088.214266072699;12201.816972745393;12211.633650990463;12213.145079844415;776.54572075336;790.5454363740844;794.8092457810142;795.8567457857583;796.044746304434;796.9043714754208;804.1476035402463;804.6178065418909;804.6861723927673;805.0862271322062;834.6119054639591;841.2891107014593;841.524538635672;841.5455653946862;842.0274582856811;836.8744688296774;836.9707060252862;837.2632083766247;837.2883049407985;837.4472847920374;617.728199592178;618.0204376063944;618.0759764152575;618.4712071179122;619.3280290884396;10724.892751072468;10849.403282819441;10883.074938630227;10887.292325998786;10888.40113793741;9097.727068187898;9673.274504412127;9814.46020468874;9926.702198934043;10203.89796102037;8231.382646301492;8264.21489958453;8311.210435008665;8326.292265157468;8424.789380265542;3176.9205769855707;3236.8219747913854;3264.836758162106;3270.5257737627912;3278.7868788528667;35412.822935885415;35938.281234375165;39078;39926.401103983466;40311.39532907009;9425.90574094264;9492.810143797085;9581.568829402693;9710.660126895526;9724.02759724022;16159.757603635955;16177.757333640006;16193.109378984269;16198.352065917466;16203.594910127342;6320.083587879823;6407.583507072025;6475.676216189172;6516.609003459807;6653.800385988428;3427.9485807712904;3471.218975730491;3474.1314671332166;3503.264314493934;3548.3967725486727;2705.3101459127797;2724.6730392352647;2725.509408306484;2729.6451461309903;2732.3169207698074;477.96176305895443;481.0139214610035;482.3705064890282;498.5014985014985;501.72154454277495;528.5164074871526;546.3907742866754;551.3576683164149;562.4993755557557;575.2263205987939;7137.321954414322;7183.676734546958;7298.132768686072;7325.2308507607;7463.253674632493;489.63277541843615;574.2964868036622;577.8526475748741;582.4175824175824;583.1573376471043;3261.608606967132;3619;3861.131245469747;3963.74235674686;4012.9197416052098;47815.521844781106;49592.256116158285;49875.501244987085;50661.240081398806;52165.217521737206;44061.559384406384;44708.77645611751;44912.10175796466;44937.77531112389;45011.54988450074;36236.27527449489;36745.265094697956;39520;40865.387019194735;41398.79300603538;7514.624268786648;7723.691052357843;7882.448228623941;8163;8193.877091843508;34007.31985360329;34263;34885.82557087198;35010;35030.47454288137;43455.13089738124;43458.78270608627;43724.781376094186;43966.340504891814;44140.77929610331;9756.219502439646;10051;10179.796404072025;10188.898111018794;10337.689869303633;11691.532338706696;11731.589394371156;11755.412229388667;12539.811902821282;12542.686432838887;10193.235507337127;10276.383416995004;10588;10830.187735919995;10860.837087443537;10141.949290253502;10266.6406675766;10467.738306542398;10557.102646275152;10806.135509159405;10113.848292275474;10378.221633377678;10379.221558383;10413.583456661649;10466.68599942003;9394.24846012331;9553.140217380469;9554.187894029086;9610.25093432974;9959.253056020973;9472.100150485692;9508.952455237679;9568.09103135201;9579.712608621752;9605.567749451431 05:43:02 INFO - 2015-11-20 05:43:02,139 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,872 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: __startTimestamp1448026982128__endTimestamp 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:43:02 INFO - 2015-11-20 05:43:02,140 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4734.86 Median:4903.53 stddev:498.57 (10.2%) stddev-sans-first:472.88 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: Values: 2663.5 2768.5 2771.8 2790.6 2807.2 4638.1 4678.4 4782.5 4791.4 4794.3 4769.1 4821.9 4856.2 4859.4 4943.3 4211.3 4452.1 4460.9 4483.2 4500.5 4212.7 4508.9 4531.1 4564.2 4579.5 4338.4 4386.1 4393.0 4396.2 4410.2 4351.0 4369.8 4372.7 4423.7 4447.0 4271.7 4428.2 4429.6 4446.9 4481.6 4694.8 4715.7 4727.7 4797.9 4863.3 5146.8 5148.4 5150.7 5161.4 5194.4 4936.5 5175.4 5176.5 5186.9 5199.9 4660.7 4683.5 4693.3 4725.6 4751.9 5287.2 5347.9 5357.3 5359.8 5360.4 5098.3 5126.1 5133.4 5143.1 5189.3 4933.4 4933.9 5030.8 5036.9 5040.5 5114.9 5115.9 5120.8 5122.3 5128.4 5089.5 5094.5 5097.3 5099.1 5158.7 4084.0 4124.9 4156.8 4182.2 4264.9 3769.5 3773.7 3793.0 3808.5 3819.8 4431.6 4433.5 4438.3 4465.6 4472.3 4939.7 5048.4 5054.6 5055.3 5205.2 4269.7 4334.4 4336.9 4358.5 4362.5 4536.0 4585.7 4593.0 4594.7 4638.4 4647.7 4782.5 4937.3 4946.0 4948.4 5144.2 5155.5 5220.2 5240.2 5282.5 4872.3 4875.4 4903.5 4915.9 4921.0 4817.6 4918.9 5076.0 5078.3 5084.5 4915.5 5000.8 5055.8 5072.2 5113.8 5039.3 5052.3 5052.8 5060.4 5104.3 5045.7 5051.6 5058.3 5065.8 5067.5 4743.6 4797.5 4849.4 4921.1 4942.2 4970.7 4999.4 5063.2 5091.1 5095.7 4930.8 4956.9 4963.3 4969.6 5004.1 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39961.71 Median:30181.90 stddev:61180.61 (202.7%) stddev-sans-first:61280.66 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: Values: 546.1 562.2 575.5 586.6 596.8 27668.9 36152.8 36839.4 36885.4 36899.3 40516.4 41227.8 41247.6 41258.4 41398.0 7067.5 7189.6 8003.7 8170.6 9889.3 10160.7 10279.3 10283.7 10285.9 10293.5 10190.7 10300.5 10302.4 10302.7 10310.3 7297.2 7486.4 10243.3 10509.6 10510.3 9930.1 10059.7 10064.0 10066.0 10070.4 37971.2 38459.8 38721.2 38735.2 38763.2 2936.1 2938.6 2947.1 3118.4 3367.4 28919.6 29276.6 29329.0 29420.7 29798.0 3312.4 3349.9 3362.6 3367.7 3476.4 224690.0 225557.0 226113.0 226127.0 226162.0 54517.2 54819.0 54825.2 54897.7 54927.5 48829.8 49654.3 63021.7 64059.7 64513.4 14880.1 15014.2 15103.5 15122.5 15134.4 10375.5 10401.7 10410.9 10424.1 10434.7 18527.4 18619.7 18639.6 18772.4 18776.2 7486.6 7635.1 7694.4 7741.6 7797.3 827.0 854.7 895.0 1050.6 1070.3 26491.6 26643.9 26812.9 26855.3 27892.9 887.5 947.5 964.1 965.1 973.1 12220.3 12321.1 12459.8 12515.6 12530.4 257515.0 258367.0 261187.0 262136.0 262613.0 45361.5 45606.0 45668.8 45682.5 45683.8 1161.9 1172.2 1194.6 1241.0 1259.2 22883.3 23809.2 24036.6 25711.0 26157.6 41115.0 41585.6 41613.0 41648.0 41676.8 216937.0 218417.0 218625.0 218877.0 219012.0 24673.5 25162.0 28372.1 28928.1 29347.6 34085.8 34353.7 38550.2 39240.2 39341.4 32683.7 32913.8 33032.7 33120.0 33633.0 33014.2 33151.9 33306.7 33312.8 33377.5 32922.5 33412.5 33413.0 33635.0 33895.5 27510.7 28457.3 29908.4 30455.4 30458.5 23053.4 23101.7 23114.3 23158.7 23371.0 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,141 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:25493.26 Median:3618.06 stddev:74781.43 (2066.9%) stddev-sans-first:74967.33 05:43:02 INFO - 2015-11-20 05:43:02,143 DEBUG : BROWSER_OUTPUT: Values: 326.1 330.1 330.3 333.2 343.6 12598.4 12891.2 14801.0 15236.1 15382.2 12716.2 14811.4 14930.3 15132.4 15143.2 4645.6 4801.7 4868.0 4994.9 5000.1 3579.7 3656.4 4985.5 5028.4 5298.9 5670.6 5682.9 5703.9 5728.8 5731.1 5422.5 5561.6 5660.2 5661.9 5662.7 4898.6 4904.6 4905.3 4906.8 4931.8 18623.3 18850.2 18977.0 18981.2 19676.0 1886.1 1918.7 1944.8 2020.3 2022.4 12461.8 12598.9 12685.0 12714.2 13072.8 1770.6 1786.2 1792.2 1794.6 1810.2 47409.7 53207.2 54939.0 55400.4 55632.0 9149.5 9431.4 9583.9 9620.2 9660.0 12144.4 12159.1 12302.5 12343.3 12373.6 7115.0 7120.5 7167.0 7229.1 7280.1 6860.7 6913.0 7066.7 7160.0 7176.0 4168.1 4245.8 4280.4 4307.5 4333.4 1513.6 1631.7 1677.7 1707.4 1734.4 903.1 956.6 972.6 989.7 1003.0 15725.4 15972.9 16359.8 16371.0 16423.8 720.3 799.8 803.0 847.9 905.2 8877.6 8899.0 8943.3 9119.5 9180.3 445945.0 451447.0 457736.7 466018.0 466955.0 71510.0 72443.6 72993.6 73158.0 73401.0 1015.3 1023.7 1031.1 1033.3 1038.1 13580.5 14131.7 14203.4 14278.3 14349.5 29084.4 29188.7 30060.4 30177.5 30259.4 38402.8 45358.5 45919.8 46762.5 47900.5 8711.9 8924.4 8944.6 9040.2 9050.0 10833.7 15355.4 15966.6 16237.7 16296.9 12611.4 13025.3 13251.7 13911.6 14049.9 12775.9 12973.1 13643.7 14125.9 14251.6 10893.3 11450.4 13510.9 13722.5 13875.2 7837.3 9213.9 9349.7 9375.8 9397.0 9946.4 11987.5 13906.6 14154.4 14375.3 05:43:02 INFO - 2015-11-20 05:43:02,143 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,143 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5009.55 Median:6067.50 stddev:2569.26 (42.3%) stddev-sans-first:2562.34 05:43:02 INFO - 2015-11-20 05:43:02,143 DEBUG : BROWSER_OUTPUT: Values: 1424.9 1670.8 1714.9 1726.1 1744.4 6401.7 6870.4 7027.6 7037.6 7058.9 7226.8 7316.5 7327.1 7330.1 7349.0 2118.5 2139.6 2142.5 2142.8 2143.8 2132.6 2167.9 2209.3 2217.7 2229.8 2111.3 2145.1 2151.4 2162.4 2164.1 2101.8 2113.2 2129.4 2131.5 2131.7 2129.6 2156.7 2174.2 2175.4 2184.6 5918.8 6059.4 7226.9 7264.5 7264.6 3842.1 3933.3 4275.8 4400.4 4424.0 2873.5 2912.1 2953.5 2957.3 3002.4 887.1 908.7 920.4 927.0 940.8 9904.7 9934.4 9948.4 9957.3 9967.6 4114.5 4189.1 4222.6 4241.0 4252.8 8623.8 8626.3 8653.0 8657.1 8666.1 4568.8 4570.9 4571.4 4572.7 4577.9 4095.1 4095.6 4101.1 4105.2 4106.4 3308.3 3317.2 3329.9 3332.4 3347.9 1102.0 1128.3 1136.5 1142.3 1144.0 1152.0 1167.6 1174.0 1177.6 1194.0 6967.2 7016.5 7074.3 7076.6 7091.6 467.1 472.5 473.5 475.4 479.8 4785.3 5319.5 5417.1 5426.4 5427.8 7715.5 8460.1 8535.4 8610.3 8630.1 8348.2 8352.5 8525.9 8542.2 8546.6 6586.0 6667.4 6669.5 6670.6 6687.0 6218.3 6227.3 6238.3 6265.3 6270.4 7159.3 7349.2 7376.8 7384.8 7402.8 7521.7 7799.6 7861.1 7907.3 7934.0 5917.2 5954.7 5997.9 6003.4 6006.0 6836.1 6870.8 6882.0 6906.1 6907.1 6182.3 6191.4 6362.6 6426.5 6444.1 6166.3 6236.9 6246.6 6248.9 6448.0 6578.1 6611.9 6626.3 6638.2 6644.1 6057.0 6080.4 6092.1 6097.3 6102.3 5852.8 6058.8 6063.9 6071.1 6071.9 05:43:02 INFO - 2015-11-20 05:43:02,144 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,144 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4710.00 Median:5435.20 stddev:1395.28 (25.7%) stddev-sans-first:1359.44 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: Values: 303.9 308.4 313.6 314.9 322.4 5273.6 5478.3 5483.6 5524.3 5542.6 5357.0 5430.6 5439.8 5440.6 5452.3 3941.3 4013.0 4021.4 4194.5 4233.5 4155.1 4172.3 4177.4 4182.1 4187.7 4123.6 4127.0 4127.1 4134.1 4134.7 3931.5 4037.5 4046.7 4138.3 4160.3 3598.2 3603.1 3603.4 3604.4 3612.5 5189.4 5189.5 5192.8 5202.0 5205.5 4740.2 4758.3 4761.0 4763.2 4771.7 5502.1 5661.5 5683.5 5693.3 5703.2 3969.0 3975.1 3975.6 3975.6 3977.2 5882.2 5963.6 5965.2 5975.9 5977.2 4062.3 4085.7 4101.0 4106.4 4108.9 4006.3 4152.8 4170.1 4170.4 4176.6 4772.7 4785.2 4790.6 4795.2 4796.0 5724.9 5735.2 5735.2 5737.3 5748.1 1451.0 1473.3 1475.6 1476.3 1478.2 975.7 984.6 990.9 992.9 1004.6 4885.2 4887.9 4899.3 4901.3 4901.9 5815.9 5819.2 5820.9 5824.6 5825.6 4882.0 4887.1 4888.3 4896.8 4904.6 2944.5 3053.2 3121.7 3137.3 3147.7 5568.2 5609.5 5643.4 5654.9 5656.3 6117.8 6123.2 6129.7 6133.4 6134.4 5617.3 5630.3 5636.7 5643.5 5649.7 5775.7 5897.4 5916.9 5920.1 5926.9 5825.5 5836.3 5837.0 5837.5 5837.9 5625.9 5630.9 5631.4 5631.9 5639.5 4010.3 4093.8 4100.8 4107.8 4115.0 5906.6 5908.2 5921.6 5922.1 5923.1 5661.0 5688.6 5691.4 5693.6 5697.8 5568.6 5648.5 5676.9 5681.2 5701.5 5570.7 5573.6 5576.1 5577.4 5579.7 5731.4 5731.9 5734.6 5735.2 5738.7 5310.4 5412.9 5491.0 5594.5 5595.5 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12312.56 Median:24146.74 stddev:14027.13 (58.1%) stddev-sans-first:14039.72 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: Values: 773.8 777.1 778.7 780.4 796.2 12164.8 12487.3 12489.2 12507.3 12511.2 11960.5 12088.2 12201.8 12211.6 12213.1 776.5 790.5 794.8 795.9 796.0 796.9 804.1 804.6 804.7 805.1 834.6 841.3 841.5 841.5 842.0 836.9 837.0 837.3 837.3 837.4 617.7 618.0 618.1 618.5 619.3 10724.9 10849.4 10883.1 10887.3 10888.4 9097.7 9673.3 9814.5 9926.7 10203.9 8231.4 8264.2 8311.2 8326.3 8424.8 3176.9 3236.8 3264.8 3270.5 3278.8 35412.8 35938.3 39078.0 39926.4 40311.4 9425.9 9492.8 9581.6 9710.7 9724.0 16159.8 16177.8 16193.1 16198.4 16203.6 6320.1 6407.6 6475.7 6516.6 6653.8 3427.9 3471.2 3474.1 3503.3 3548.4 2705.3 2724.7 2725.5 2729.6 2732.3 478.0 481.0 482.4 498.5 501.7 528.5 546.4 551.4 562.5 575.2 7137.3 7183.7 7298.1 7325.2 7463.3 489.6 574.3 577.9 582.4 583.2 3261.6 3619.0 3861.1 3963.7 4012.9 47815.5 49592.3 49875.5 50661.2 52165.2 44061.6 44708.8 44912.1 44937.8 45011.5 36236.3 36745.3 39520.0 40865.4 41398.8 7514.6 7723.7 7882.4 8163.0 8193.9 34007.3 34263.0 34885.8 35010.0 35030.5 43455.1 43458.8 43724.8 43966.3 44140.8 9756.2 10051.0 10179.8 10188.9 10337.7 11691.5 11731.6 11755.4 12539.8 12542.7 10193.2 10276.4 10588.0 10830.2 10860.8 10141.9 10266.6 10467.7 10557.1 10806.1 10113.8 10378.2 10379.2 10413.6 10466.7 9394.2 9553.1 9554.2 9610.3 9959.3 9472.1 9509.0 9568.1 9579.7 9605.6 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:43:02 INFO - 2015-11-20 05:43:02,145 DEBUG : BROWSER_OUTPUT: 05:43:02 INFO - 2015-11-20 05:43:02,909 INFO : Browser exited with error code: 0 05:43:02 INFO - 2015-11-20 05:43:02,925 INFO : Completed test dromaeo_css (00:18:39) 05:43:02 INFO - 2015-11-20 05:43:02,925 INFO : Starting test kraken 05:43:02 INFO - 2015-11-20 05:43:02,925 DEBUG : operating with platform_type : linux_ 05:43:02 INFO - 2015-11-20 05:43:02,926 INFO : Initialising browser for kraken test... 05:43:02 INFO - 2015-11-20 05:43:02,932 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSodd0/profile http://localhost:51496/getInfo.html 05:43:07 INFO - 2015-11-20 05:43:07,015 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:43:07 INFO - 2015-11-20 05:43:07,016 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:43:07 INFO - 2015-11-20 05:43:07,016 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:43:07 INFO - 2015-11-20 05:43:07,016 DEBUG : BROWSER_OUTPUT: __metrics 05:43:07 INFO - 2015-11-20 05:43:07,177 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:43:08 INFO - 2015-11-20 05:43:08,451 INFO : Browser initialized. 05:43:08 INFO - 2015-11-20 05:43:08,452 INFO : Running cycle 1/1 for kraken test... 05:43:08 INFO - 2015-11-20 05:43:08,452 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpBSodd0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:43:20 INFO - 2015-11-20 05:43:20,402 DEBUG : BROWSER_OUTPUT: RSS: Main: 142118912 05:43:20 INFO - 2015-11-20 05:43:20,402 DEBUG : BROWSER_OUTPUT: 05:43:23 INFO - 2015-11-20 05:43:23,038 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51496/tests/kraken/driver.html?testName=audio-beat-detection) 05:43:23 INFO - 2015-11-20 05:43:23,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 176713728 05:43:23 INFO - 2015-11-20 05:43:23,619 DEBUG : BROWSER_OUTPUT: 05:43:26 INFO - 2015-11-20 05:43:26,337 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51496/tests/kraken/driver.html?testName=audio-dft) 05:43:26 INFO - 2015-11-20 05:43:26,910 DEBUG : BROWSER_OUTPUT: RSS: Main: 166023168 05:43:26 INFO - 2015-11-20 05:43:26,911 DEBUG : BROWSER_OUTPUT: 05:43:29 INFO - 2015-11-20 05:43:29,932 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51496/tests/kraken/driver.html?testName=audio-fft) 05:43:30 INFO - 2015-11-20 05:43:30,497 DEBUG : BROWSER_OUTPUT: RSS: Main: 152899584 05:43:30 INFO - 2015-11-20 05:43:30,497 DEBUG : BROWSER_OUTPUT: 05:43:32 INFO - 2015-11-20 05:43:32,534 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51496/tests/kraken/driver.html?testName=audio-oscillator) 05:43:33 INFO - 2015-11-20 05:43:33,107 DEBUG : BROWSER_OUTPUT: RSS: Main: 154189824 05:43:33 INFO - 2015-11-20 05:43:33,107 DEBUG : BROWSER_OUTPUT: 05:43:35 INFO - 2015-11-20 05:43:35,305 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51496/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:43:35 INFO - 2015-11-20 05:43:35,871 DEBUG : BROWSER_OUTPUT: RSS: Main: 155320320 05:43:35 INFO - 2015-11-20 05:43:35,871 DEBUG : BROWSER_OUTPUT: 05:43:38 INFO - 2015-11-20 05:43:38,834 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51496/tests/kraken/driver.html?testName=imaging-darkroom) 05:43:39 INFO - 2015-11-20 05:43:39,403 DEBUG : BROWSER_OUTPUT: RSS: Main: 157179904 05:43:39 INFO - 2015-11-20 05:43:39,404 DEBUG : BROWSER_OUTPUT: 05:43:42 INFO - 2015-11-20 05:43:42,830 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51496/tests/kraken/driver.html?testName=imaging-desaturate) 05:43:43 INFO - 2015-11-20 05:43:43,416 DEBUG : BROWSER_OUTPUT: RSS: Main: 158064640 05:43:43 INFO - 2015-11-20 05:43:43,416 DEBUG : BROWSER_OUTPUT: 05:43:46 INFO - 2015-11-20 05:43:46,238 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51496/tests/kraken/driver.html?testName=json-parse-financial) 05:43:46 INFO - 2015-11-20 05:43:46,820 DEBUG : BROWSER_OUTPUT: RSS: Main: 157335552 05:43:46 INFO - 2015-11-20 05:43:46,820 DEBUG : BROWSER_OUTPUT: 05:43:48 INFO - 2015-11-20 05:43:48,557 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51496/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:43:49 INFO - 2015-11-20 05:43:49,126 DEBUG : BROWSER_OUTPUT: RSS: Main: 163340288 05:43:49 INFO - 2015-11-20 05:43:49,127 DEBUG : BROWSER_OUTPUT: 05:43:51 INFO - 2015-11-20 05:43:51,021 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:43:51 INFO - 2015-11-20 05:43:51,611 DEBUG : BROWSER_OUTPUT: RSS: Main: 164331520 05:43:51 INFO - 2015-11-20 05:43:51,611 DEBUG : BROWSER_OUTPUT: 05:43:53 INFO - 2015-11-20 05:43:53,733 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:43:54 INFO - 2015-11-20 05:43:54,314 DEBUG : BROWSER_OUTPUT: RSS: Main: 173707264 05:43:54 INFO - 2015-11-20 05:43:54,314 DEBUG : BROWSER_OUTPUT: 05:43:56 INFO - 2015-11-20 05:43:56,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:43:57 INFO - 2015-11-20 05:43:57,394 DEBUG : BROWSER_OUTPUT: RSS: Main: 179781632 05:43:57 INFO - 2015-11-20 05:43:57,394 DEBUG : BROWSER_OUTPUT: 05:43:59 INFO - 2015-11-20 05:43:59,955 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:44:00 INFO - 2015-11-20 05:44:00,536 DEBUG : BROWSER_OUTPUT: RSS: Main: 177680384 05:44:00 INFO - 2015-11-20 05:44:00,536 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,270 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51496/tests/kraken/driver.html?testName=ai-astar) 05:44:02 INFO - 2015-11-20 05:44:02,520 DEBUG : BROWSER_OUTPUT: RSS: Main: 236462080 05:44:02 INFO - 2015-11-20 05:44:02,520 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,520 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:44:02 INFO - 2015-11-20 05:44:02,520 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;111;105;111;113;112;102;110;102;112 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;128;154;175;130;154;155;130;177;130 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |2;audio-dft;162;162;161;159;160;159;161;163;163;164 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |3;audio-fft;72;72;84;92;72;72;72;96;88;74 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;127;91;91;91;132;91;92;130 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;110;110;109;110;110;109;110;110;110;111 05:44:02 INFO - 2015-11-20 05:44:02,521 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;148;146;148;146;147;146;147;146;147;146 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;96;96;97;95;95;95;96;95;96 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;70;70;71;70;69;69;78;67;69 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;69;71;70;70;70;69;68;69;70;69 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;82;83;84;84;84;84;84;86;85;82 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;126;119;117;122;124;126;124;121;129;124 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;143;136;146;145;136;136;144;143;148;133 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;69;70;69;68;68;68;69;70;69 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,982 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:44:02 INFO - 2015-11-20 05:44:02,522 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027042519__endTimestamp 05:44:02 INFO - 2015-11-20 05:44:02,523 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.80 Median:111.00 stddev:4.18 (3.8%) stddev-sans-first:4.42 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: Values: 110.0 111.0 105.0 111.0 113.0 112.0 102.0 110.0 102.0 112.0 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.90 Median:154.50 stddev:18.62 (12.0%) stddev-sans-first:19.57 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: Values: 156.0 128.0 154.0 175.0 130.0 154.0 155.0 130.0 177.0 130.0 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.40 Median:162.00 stddev:1.71 (1.1%) stddev-sans-first:1.80 05:44:02 INFO - 2015-11-20 05:44:02,526 DEBUG : BROWSER_OUTPUT: Values: 162.0 162.0 161.0 159.0 160.0 159.0 161.0 163.0 163.0 164.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:79.40 Median:79.00 stddev:9.62 (12.2%) stddev-sans-first:9.82 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: Values: 72.0 72.0 84.0 92.0 72.0 72.0 72.0 96.0 88.0 74.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.80 Median:91.00 stddev:18.58 (20.4%) stddev-sans-first:19.29 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 127.0 91.0 91.0 91.0 132.0 91.0 92.0 130.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.90 Median:110.00 stddev:0.57 (0.5%) stddev-sans-first:0.60 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: Values: 110.0 110.0 109.0 110.0 110.0 109.0 110.0 110.0 110.0 111.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.70 Median:147.00 stddev:0.82 (0.6%) stddev-sans-first:0.73 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 148.0 146.0 147.0 146.0 147.0 146.0 147.0 146.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.70 Median:96.00 stddev:0.67 (0.7%) stddev-sans-first:0.71 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: Values: 96.0 96.0 96.0 97.0 95.0 95.0 95.0 96.0 95.0 96.0 05:44:02 INFO - 2015-11-20 05:44:02,527 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:70.20 Median:70.00 stddev:2.94 (4.2%) stddev-sans-first:3.08 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: Values: 69.0 70.0 70.0 71.0 70.0 69.0 69.0 78.0 67.0 69.0 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:69.50 Median:70.00 stddev:0.85 (1.2%) stddev-sans-first:0.88 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: Values: 69.0 71.0 70.0 70.0 70.0 69.0 68.0 69.0 70.0 69.0 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:83.80 Median:84.00 stddev:1.23 (1.5%) stddev-sans-first:1.12 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: Values: 82.0 83.0 84.0 84.0 84.0 84.0 84.0 86.0 85.0 82.0 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:123.20 Median:124.00 stddev:3.55 (2.9%) stddev-sans-first:3.62 05:44:02 INFO - 2015-11-20 05:44:02,528 DEBUG : BROWSER_OUTPUT: Values: 126.0 119.0 117.0 122.0 124.0 126.0 124.0 121.0 129.0 124.0 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:141.00 Median:143.50 stddev:5.23 (3.6%) stddev-sans-first:5.49 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: Values: 143.0 136.0 146.0 145.0 136.0 136.0 144.0 143.0 148.0 133.0 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.90 Median:69.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: Values: 69.0 69.0 70.0 69.0 68.0 68.0 68.0 69.0 70.0 69.0 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:44:02 INFO - 2015-11-20 05:44:02,529 DEBUG : BROWSER_OUTPUT: 05:44:03 INFO - 2015-11-20 05:44:03,437 INFO : Browser exited with error code: 0 05:44:03 INFO - 2015-11-20 05:44:03,485 INFO : Completed test kraken (00:01:00) 05:44:03 INFO - 2015-11-20 05:44:03,485 INFO : Starting test v8_7 05:44:03 INFO - 2015-11-20 05:44:03,486 DEBUG : operating with platform_type : linux_ 05:44:03 INFO - 2015-11-20 05:44:03,486 INFO : Initialising browser for v8_7 test... 05:44:03 INFO - 2015-11-20 05:44:03,492 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJoiEy/profile http://localhost:51496/getInfo.html 05:44:07 INFO - 2015-11-20 05:44:07,573 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:44:07 INFO - 2015-11-20 05:44:07,573 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:44:07 INFO - 2015-11-20 05:44:07,573 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 05:44:07 INFO - 2015-11-20 05:44:07,573 DEBUG : BROWSER_OUTPUT: __metrics 05:44:07 INFO - 2015-11-20 05:44:07,722 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:44:09 INFO - 2015-11-20 05:44:09,061 INFO : Browser initialized. 05:44:09 INFO - 2015-11-20 05:44:09,062 INFO : Running cycle 1/1 for v8_7 test... 05:44:09 INFO - 2015-11-20 05:44:09,062 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpbJoiEy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:44:21 INFO - 2015-11-20 05:44:21,056 DEBUG : BROWSER_OUTPUT: RSS: Main: 141275136 05:44:21 INFO - 2015-11-20 05:44:21,056 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,414 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:51496/tests/v8_7/run.html (next: http://localhost:51496/tests/v8_7/run.html) 05:44:42 INFO - 2015-11-20 05:44:42,664 DEBUG : BROWSER_OUTPUT: RSS: Main: 442294272 05:44:42 INFO - 2015-11-20 05:44:42,664 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,664 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:44:42 INFO - 2015-11-20 05:44:42,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:44:42 INFO - 2015-11-20 05:44:42,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |0;Richards;163.23865491348351 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;192.34468166955185 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |2;Encrypt;280.42624789680315 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |4;RayTrace;2051.2295081967213 05:44:42 INFO - 2015-11-20 05:44:42,665 DEBUG : BROWSER_OUTPUT: |5;Earley;791.7656373713381 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: |6;Boyer;12500 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: |7;RegExp;27162.162162162163 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: |8;Splay;619.5786864931846 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4850.241545893719 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:44:42 INFO - 2015-11-20 05:44:42,666 DEBUG : BROWSER_OUTPUT: __startTimestamp1448027082663__endTimestamp 05:44:42 INFO - 2015-11-20 05:44:42,667 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,667 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:44:42 INFO - 2015-11-20 05:44:42,667 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:44:42 INFO - 2015-11-20 05:44:42,667 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,667 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.24 Median:163.24 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,668 DEBUG : BROWSER_OUTPUT: Values: 163.2 05:44:42 INFO - 2015-11-20 05:44:42,668 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,668 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:192.34 Median:192.34 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,668 DEBUG : BROWSER_OUTPUT: Values: 192.3 05:44:42 INFO - 2015-11-20 05:44:42,668 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:280.43 Median:280.43 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: Values: 280.4 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: Values: 5030.2 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,670 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:2051.23 Median:2051.23 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: Values: 2051.2 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:791.77 Median:791.77 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: Values: 791.8 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12500.00 Median:12500.00 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,671 DEBUG : BROWSER_OUTPUT: Values: 12500.0 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:27162.16 Median:27162.16 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: Values: 27162.2 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:619.58 Median:619.58 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: Values: 619.6 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: 05:44:42 INFO - 2015-11-20 05:44:42,672 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4850.24 Median:4850.24 stddev:0.00 (0.0%) 05:44:42 INFO - 2015-11-20 05:44:42,673 DEBUG : BROWSER_OUTPUT: Values: 4850.2 05:44:42 INFO - 2015-11-20 05:44:42,673 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:44:42 INFO - 2015-11-20 05:44:42,673 DEBUG : BROWSER_OUTPUT: 05:44:43 INFO - 2015-11-20 05:44:43,633 INFO : Browser exited with error code: 0 05:44:43 INFO - 2015-11-20 05:44:43,648 INFO : Completed test v8_7 (00:00:40) 05:44:43 INFO - 2015-11-20 05:44:43,749 INFO : Completed test suite (00:20:19) 05:44:43 INFO - 2015-11-20 05:44:43,749 DEBUG : Working with test: dromaeo_css 05:44:43 INFO - 2015-11-20 05:44:43,749 DEBUG : Generating results file: dromaeo_css 05:44:43 INFO - 2015-11-20 05:44:43,750 DEBUG : Working with test: kraken 05:44:43 INFO - 2015-11-20 05:44:43,751 DEBUG : Generating results file: kraken 05:44:43 INFO - 2015-11-20 05:44:43,751 INFO : javascript benchmark 05:44:43 INFO - 2015-11-20 05:44:43,751 DEBUG : Working with test: v8_7 05:44:43 INFO - 2015-11-20 05:44:43,751 DEBUG : Generating results file: v8_7 05:44:43 INFO - 2015-11-20 05:44:43,751 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:43 INFO - 2015-11-20 05:44:43,796 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 05:44:43 INFO - 2015-11-20 05:44:43,797 DEBUG : process_Request line: dromaeo_css 6370.69 graph.html#tests=[[72,94,35]] 05:44:43 INFO - 2015-11-20 05:44:43,797 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:43 INFO - 2015-11-20 05:44:43,830 DEBUG : process_Request line: kraken 1510.20 graph.html#tests=[[232,94,35]] 05:44:43 INFO - 2015-11-20 05:44:43,830 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:44:43 INFO - 2015-11-20 05:44:43,858 DEBUG : process_Request line: v8_7 19627.70 graph.html#tests=[[230,94,35]] 05:44:43 INFO - 2015-11-20 05:44:43,859 INFO : javascript benchmark 05:44:43 INFO - 2015-11-20 05:44:43,862 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2663.5205662980666, 2768.4878297514947, 2771.8475483848392, 2790.595363672266, 2807.2420446479446, 4638.072385522892, 4678.438587369516, 4782.450018247902, 4791.425028996521, 4794.280857871321, 4769.141554520185, 4821.855344339676, 4856.198727210006, 4859.368282123328, 4943.332650092237, 4211.275941546421, 4452.131834292314, 4460.933086003713, 4483.170613436509, 4500.5499450054895, 4212.705110642256, 4508.932366014513, 4531.139083574127, 4564.178447879381, 4579.519150489201, 4338.370936214263, 4386.122775444892, 4392.956070439319, 4396.230659634567, 4410.184115938561, 4350.963093443206, 4369.781510924441, 4372.672049596293, 4423.690341676084, 4447.021655235843, 4271.722338048017, 4428.22506061438, 4429.623482004034, 4446.866594002185, 4481.641468682497, 4694.765261736899, 4715.693479923828, 4727.692699974525, 4797.904041919142, 4863.343448634424, 5146.7683954221775, 5148.433672296044, 5150.716710580917, 5161.406438259611, 5194.402643695986, 4936.5063493650705, 5175.378954525443, 5176.50823171798, 5186.948130518685, 5199.922001169985, 4660.6970546914345, 4683.461401938786, 4693.272542755878, 4725.5983241424865, 4751.928721069186, 5287.23335116406, 5347.866303342447, 5357.303550538405, 5359.839204823861, 5360.437154098841, 5098.286239926413, 5126.102931986888, 5133.435322114565, 5143.099957507421, 5189.3253876996505, 4933.358663373739, 4933.9013219736125, 5030.8239211627415, 5036.924446133311, 5040.521150490697, 5114.897702045938, 5115.948840511547, 5120.80170660321, 5122.282880396748, 5128.435872054071, 5089.541941225233, 5094.49055094495, 5097.311862898536, 5099.056674515226, 5158.74206289684, 4083.97958010214, 4124.91750164995, 4156.750594964312, 4182.247195504778, 4264.936025959613, 3769.509963704701, 3773.735838491279, 3792.981035094807, 3808.5429748430365, 3819.7708137511836, 4431.556844315543, 4433.512313645497, 4438.267685831866, 4465.553444655508, 4472.306792447176, 4939.703617782944, 5048.368953880765, 5054.646174767731, 5055.317532133188, 5205.167173252337, 4269.7224680395675, 4334.43652325202, 4336.891577710582, 4358.455193100863, 4362.476502819682, 4536.0, 4585.679002469795, 4592.977035114803, 4594.6783725139585, 4638.397008388888, 4647.65142614312, 4782.521747825329, 4937.308776771255, 4946.03552307311, 4948.406191257072, 5144.176931690911, 5155.510226528474, 5220.190870415092, 5240.187770895517, 5282.498162674539, 4872.317875497504, 4875.390576177978, 4903.534164254533, 4915.852524424273, 4921.040397122527, 4817.638677099161, 4918.92621610669, 5076.0, 5078.314427552381, 5084.491550844886, 4915.508449155056, 5000.824971125993, 5055.797768089235, 5072.213806859942, 5113.769880355468, 5039.294498770102, 5052.267421223975, 5052.8484145475695, 5060.367454068241, 5104.310918026019, 5045.6720313180995, 5051.646384753179, 5058.291839142449, 5065.797368105382, 5067.5185857343495, 4743.644226683082, 4797.496262892346, 4849.393825771778, 4921.13880070979, 4942.233953737176, 4970.701757894538, 4999.375078115236, 5063.240513922941, 5091.134507133722, 5095.668781529189, 4930.778114984762, 4956.925646115239, 4963.305137280856, 4969.552740253394, 5004.1492946198505], "unit": "ms", "name": "dojo.html", "value": 4703.87289423561}, {"lowerIsBetter": false, "replicates": [546.1496450027306, 562.2269379603046, 575.5194412665425, 586.5776640818609, 596.8331911113773, 27668.86165569172, 36152.819235903815, 36839.44740828886, 36885.44671829918, 36899.26201475969, 40516.39225411614, 41227.79386103065, 41247.58752412475, 41258.381124283085, 41398.0, 7067.469939754514, 7189.640517974107, 8003.679852805895, 8170.550619715913, 9889.25830562707, 10160.695179144637, 10279.280450368477, 10283.691489255334, 10285.897141028569, 10293.53679084443, 10190.6942791716, 10300.536475858604, 10302.433366164858, 10302.690919272434, 10310.278280520366, 7297.197308296083, 7486.401087912981, 10243.334183278137, 10509.632162874263, 10510.31682940614, 9930.106290433896, 10059.748506287327, 10064.043915827984, 10066.0, 10070.395776253448, 37971.24057518834, 38459.80770096132, 38721.22557548833, 38735.225295494216, 38763.22473550513, 2936.07513633207, 2938.6326709161353, 2947.071672423201, 3118.3607360491046, 3367.44437167867, 28919.56620650692, 29276.560851587245, 29329.0, 29420.70579294201, 29798.0, 3312.4285367797306, 3349.949750753716, 3362.613299470543, 3367.71374433171, 3476.4090104682014, 224690.0, 225557.0, 226113.0, 226126.99999999834, 226162.0, 54517.1822422664, 54819.0, 54825.177622335694, 54897.725511372984, 54927.450725492236, 48829.755851220514, 49654.25518617224, 63021.68489157525, 64059.67970160119, 64513.35486645073, 14880.107193568421, 15014.24928753558, 15103.4713785017, 15122.470713524974, 15134.394624214909, 10375.481225938824, 10401.68794936153, 10410.895891041144, 10424.113950314157, 10434.739131521621, 18527.444176674722, 18619.720704189447, 18639.627207456047, 18772.436826895217, 18776.248950041845, 7486.577550265432, 7635.083789945242, 7694.384449244047, 7741.574213418204, 7797.259260370256, 826.9875951860727, 854.6581367452944, 894.9776255593662, 1050.5850189175385, 1070.272214893864, 26491.602625960626, 26643.866780665972, 26812.865935670197, 26855.328616784347, 27892.860535697597, 887.4941283468361, 947.4978261521404, 964.0504103458088, 965.1169180200038, 973.1193270090579, 12220.266783992989, 12321.137520373488, 12459.750804983849, 12515.56195533152, 12530.436130374155, 257515.0, 258367.0, 261187.0, 262136.0, 262613.0, 45361.54638453639, 45606.0, 45668.77165614151, 45682.54317456783, 45683.77158114188, 1161.9477123529462, 1172.1619042384907, 1194.6236935365332, 1240.9823944365714, 1259.200407741091, 22883.31350059501, 23809.214892735858, 24036.63945040861, 25711.0, 26157.607635885095, 41115.0, 41585.58414415938, 41613.0, 41648.0, 41676.79161604172, 216937.0, 218417.0, 218625.0, 218877.0, 219012.0, 24673.50652986966, 25162.0, 28372.148835534143, 28928.132156035354, 29347.55978660279, 34085.82957085199, 34353.65646343504, 38550.2289954205, 39240.215195696495, 39341.40987885241, 32683.673163268064, 32913.83543082269, 33032.66967330296, 33120.0, 33633.0, 33014.17464563405, 33151.861461472545, 33306.666933331326, 33312.83343583267, 33377.49933750947, 32922.50616240806, 33412.49881251735, 33413.0, 33635.0, 33895.491567626996, 27510.724892751616, 28457.28856778597, 29908.401831963674, 30455.390892182477, 30458.54312185275, 23053.423664407852, 23101.65347519822, 23114.306570802903, 23158.652620211047, 23371.0], "unit": "ms", "name": "ext.html", "value": 17187.25599882171}, {"lowerIsBetter": false, "replicates": [326.1243561038613, 330.0593309069152, 330.2519792669603, 333.1604357020309, 343.5844321395849, 12598.370081495934, 12891.226526408398, 14801.0, 15236.085834849902, 15382.153981531012, 12716.173448725825, 14811.407543698266, 14930.328135233913, 15132.394704211818, 15143.24283785809, 4645.55867192617, 4801.711897286156, 4868.026394721052, 4994.850154495371, 5000.07498612756, 3579.67782899539, 3656.433252845813, 4985.526374994388, 5028.396592408898, 5298.92051619226, 5670.574706896979, 5682.886342273152, 5703.914441283384, 5728.828135155952, 5731.1116776899435, 5422.48486393792, 5561.63849349793, 5660.150977353389, 5661.886762264773, 5662.716864156796, 4898.5591296783105, 4904.6321525885705, 4905.2887331337115, 4906.803727850882, 4931.802727890916, 18623.348182813537, 18850.245990160376, 18977.0, 18981.24075036997, 19676.0, 1886.0852486544015, 1918.673825449677, 1944.7957964413674, 2020.2928974858828, 2022.4033909996585, 12461.813072803916, 12598.937005315007, 12685.0, 12714.237145771283, 13072.803907941388, 1770.5927636643644, 1786.2497750944635, 1792.1755992243584, 1794.5693033671826, 1810.1582764014797, 47409.65150401693, 53207.20189197165, 54939.0, 55400.445995540336, 55632.0, 9149.496777677292, 9431.434113953184, 9583.856242156373, 9620.182284505756, 9659.951700241454, 12144.392780360946, 12159.088068394905, 12302.507899683913, 12343.321117338633, 12373.566925157576, 7115.0, 7120.537165084253, 7167.0, 7229.132504099436, 7280.053593032978, 6860.656967151623, 6912.965435172792, 7066.6819993100435, 7160.033395491646, 7175.964120179366, 4168.103857670615, 4245.830166793356, 4280.443542339538, 4307.483102027714, 4333.371661109121, 1513.6291608555755, 1631.6818220447137, 1677.7231756760243, 1707.4109432245855, 1734.3669560610285, 903.0923921458892, 956.6125719083782, 972.557486343712, 989.6684610655367, 1002.9598816047277, 15725.370985160695, 15972.920135399481, 16359.83640163607, 16371.0, 16423.753643695352, 720.2749415150789, 799.7520768561648, 803.0, 847.8897743293332, 905.2350763604743, 8877.600507977157, 8899.0, 8943.329250306122, 9119.544022798833, 9180.265578753684, 445945.0, 451447.0, 457736.7113164413, 466018.0, 466955.0, 71510.0, 72443.6377818118, 72993.63503182556, 73158.0, 73401.0, 1015.2994433840627, 1023.744063984004, 1031.1132426113536, 1033.3180101133216, 1038.1072277841201, 13580.45678172862, 14131.717365652425, 14203.431862725376, 14278.286085695881, 14349.497767578503, 29084.418311634072, 29188.708112918597, 30060.398792024476, 30177.54733678953, 30259.394812103194, 38402.807985959895, 45358.546414535434, 45919.77040114778, 46762.532374677176, 47900.520994791, 8711.91288087111, 8924.375293729376, 8944.597493112955, 9040.186383225542, 9050.0, 10833.67498975032, 15355.385784568938, 15966.60083497922, 16237.675246494768, 16296.918515407348, 12611.432485538357, 13025.283609401575, 13251.66870828237, 13911.582652520441, 14049.859501405264, 12775.936120319338, 12973.09188356806, 13643.658908527366, 14125.858741412454, 14251.64370890736, 10893.311536711823, 11450.427478625868, 13510.93244533771, 13722.519711810039, 13875.236861972284, 7837.333826624573, 9213.861792073258, 9349.719508414759, 9375.765605859635, 9397.0, 9946.403215807075, 11987.520499180284, 13906.58280251594, 14154.363053662404, 14375.28123593837], "unit": "ms", "name": "jquery.html", "value": 8290.435103426214}, {"lowerIsBetter": false, "replicates": [1424.9287535623216, 1670.8329167083293, 1714.9314027438902, 1726.1283052058711, 1744.4330592557421, 6401.679916004198, 6870.38166565009, 7027.578345299273, 7037.612931288777, 7058.858822823547, 7226.7831965041005, 7316.524425912312, 7327.0841144856895, 7330.120385553728, 7349.0, 2118.533922537043, 2139.5506943541873, 2142.528643698384, 2142.78572142786, 2143.839212059102, 2132.626790311697, 2167.9132834686593, 2209.304069218191, 2217.678436626696, 2229.7658745831695, 2111.345482900298, 2145.0776166248506, 2151.365347222565, 2162.4485756132162, 2164.0694501364405, 2101.7582977957577, 2113.2286715348864, 2129.4144110369693, 2131.488442773731, 2131.6589345704615, 2129.563439494915, 2156.6549352103743, 2174.1738139507042, 2175.4126385875725, 2184.595849767798, 5918.822435326947, 6059.363766804466, 7226.891596626055, 7264.4914855960105, 7264.600446975414, 3842.1163132479405, 3933.2723446162267, 4275.764832934187, 4400.44994375703, 4424.048829501673, 2873.4971380008624, 2912.126362091364, 2953.4683756923746, 2957.31981644223, 3002.4145291668133, 887.130612000237, 908.6501696846695, 920.3603495570514, 927.0219917986522, 940.7883226274033, 9904.653337133166, 9934.354266972696, 9948.353357031841, 9957.302988790787, 9967.601295948081, 4114.526829414655, 4189.120284740177, 4222.59885310895, 4241.024564350217, 4252.808623611945, 8623.78440538979, 8626.309895208367, 8653.0, 8657.134286571292, 8666.133386661284, 4568.794404251817, 4570.9314360284625, 4571.3600095986585, 4572.679912406166, 4577.908441831145, 4095.0581366285323, 4095.5904409559403, 4101.05675694586, 4105.220008198433, 4106.3635136553885, 3308.2887179256577, 3317.1872891141343, 3329.8501567429525, 3332.3501917125927, 3347.916302092467, 1101.9944900275448, 1128.306091753582, 1136.4715407335464, 1142.3264916896785, 1143.9942800286112, 1151.9942400287946, 1167.6380322100006, 1173.9530418783154, 1177.591824718453, 1193.9880601193877, 6967.163940327092, 7016.543924644881, 7074.327938845801, 7076.575405475688, 7091.574505529685, 467.1031619290969, 472.49443095887756, 473.5453964194343, 475.44135640622824, 479.83685546914217, 4785.282207668808, 5319.521243088063, 5417.079096553595, 5426.430224826416, 5427.83716488506, 7715.498492598075, 8460.111688272766, 8535.420947124801, 8610.268127209132, 8630.093840146694, 8348.206920342558, 8352.540610266373, 8525.872111918326, 8542.18849209324, 8546.61540230691, 6585.967070164618, 6667.366600172976, 6669.533132680763, 6670.566413183127, 6686.99695045747, 6218.315985241529, 6227.314995350417, 6238.313785483502, 6265.310815810166, 6270.372962703693, 7159.319864612853, 7349.154847192427, 7376.7786966391095, 7384.815379615553, 7402.814929626802, 7521.661525231487, 7799.6100194988885, 7861.135275119618, 7907.327877130509, 7933.9603301983125, 5917.1715959766525, 5954.672493012926, 5997.880042399041, 6003.3996600339615, 6006.009008513546, 6836.077129587442, 6870.7595234166565, 6881.965590172017, 6906.067680863019, 6907.13660792401, 6182.289036760651, 6191.442770150708, 6362.554621176473, 6426.485881129592, 6444.13004244421, 6166.260048794174, 6236.937630623635, 6246.593971391845, 6248.875022499434, 6447.967760161169, 6578.0790689304495, 6611.900821487586, 6626.337366263335, 6638.17022872141, 6644.103046088716, 6057.0, 6080.422359875804, 6092.147099405998, 6097.298810636834, 6102.267727872683, 5852.7658893643775, 6058.787942421994, 6063.878722425438, 6071.119687645179, 6071.939280607314], "unit": "ms", "name": "mootools.html", "value": 4087.5963406158644}, {"lowerIsBetter": false, "replicates": [303.9133846853647, 308.3601526831824, 313.5876322635733, 314.87090292979883, 322.41481710695103, 5273.551748101411, 5478.287822583064, 5483.643563168402, 5524.254225679537, 5542.63972841766, 5356.9732151339185, 5430.619856610039, 5439.782408703657, 5440.646357986728, 5452.291202143716, 3941.27086488999, 4012.9799351003203, 4021.4369988201674, 4194.475690538683, 4233.491980962289, 4155.106652069804, 4172.290710579194, 4177.373393990911, 4182.079942412664, 4187.664986801049, 4123.567025462328, 4126.979365103185, 4127.09203975125, 4134.090500089976, 4134.697570265372, 3931.547871994714, 4037.454943582608, 4046.676265898721, 4138.296489596776, 4160.271952408347, 3598.24436868258, 3603.0632035670915, 3603.3694103531775, 3604.3692353838237, 3612.5123108380294, 5189.42916279209, 5189.481051894818, 5192.766325515323, 5202.037623039712, 5205.479452054802, 4740.241561350202, 4758.286257061469, 4761.0, 4763.214069678499, 4771.71369717818, 5502.064649009678, 5661.5187709044785, 5683.488486036276, 5693.316801983747, 5703.17303990919, 3969.0474286171398, 3975.1453437511072, 3975.6024397560013, 3975.6223158799867, 3977.204559088194, 5882.205902203191, 5963.5527335450015, 5965.164876917279, 5975.940240597625, 5977.22296101504, 4062.289099407592, 4085.7344272622186, 4100.958990410118, 4106.384042393605, 4108.876733697994, 4006.2988976928923, 4152.792360381969, 4170.145120250341, 4170.374443833449, 4176.644985176234, 4772.7136371817105, 4785.234362501983, 4790.640701947298, 4795.184818580849, 4796.040791841646, 5724.914126288109, 5735.168400581976, 5735.225744524436, 5737.340205876294, 5748.13777933305, 1450.9564713058626, 1473.2633683158422, 1475.6089636246188, 1476.3061361160237, 1478.1648368671665, 975.7267964969819, 984.6110786239395, 990.8860481044628, 992.9156021738233, 1004.5981607357115, 4885.2427873679635, 4887.926681099786, 4899.314096026559, 4901.3383193269165, 4901.926471102936, 5815.912761308584, 5819.214406055213, 5820.88358232833, 5824.592278540546, 5825.563082768809, 4882.023595280958, 4887.120318342732, 4888.266759986031, 4896.779644915988, 4904.60763138948, 2944.484715174836, 3053.2366908272934, 3121.71904528589, 3137.30979184579, 3147.7009684080435, 5568.220449137124, 5609.467100625434, 5643.435656434406, 5654.858628534237, 5656.2929633795775, 6117.755289788448, 6123.234595675541, 6129.724162412702, 6133.355997620275, 6134.38656134383, 5617.269754931833, 5630.324361076615, 5636.718164091861, 5643.492085712305, 5649.745761440745, 5775.740091695968, 5897.439743224387, 5916.881662366814, 5920.141579471038, 5926.911096333472, 5825.50483208932, 5836.328822185503, 5837.0368889132815, 5837.503812176013, 5837.854053648693, 5625.943740562542, 5630.887382252414, 5631.380548139619, 5631.929933312657, 5639.492445679908, 4010.318245898146, 4093.7748423836974, 4100.774457404871, 4107.774072425926, 4115.0, 5906.586538942404, 5908.172855800278, 5921.644701317935, 5922.1412895130825, 5923.08192230205, 5661.037623603915, 5688.5733569981585, 5691.430856914276, 5693.601447898607, 5697.829065128053, 5568.610197286151, 5648.491635752802, 5676.886462270814, 5681.2330335404195, 5701.458361455655, 5570.721463926707, 5573.6098473106495, 5576.052071147834, 5577.386487486455, 5579.6652200868075, 5731.398203188605, 5731.885362292647, 5734.598578099493, 5735.197072409949, 5738.741756620879, 5310.389305229948, 5412.864678383072, 5490.972545137249, 5594.496495315441, 5595.496405323541], "unit": "ms", "name": "prototype.html", "value": 4263.778283085858}, {"lowerIsBetter": false, "replicates": [773.8374941262331, 777.1102088109113, 778.7040924448712, 780.402991711341, 796.1918652567641, 12164.81752773708, 12487.251784750142, 12489.188202766814, 12507.312097834616, 12511.18677285977, 11960.461779219935, 12088.214266072699, 12201.816972745393, 12211.633650990463, 12213.145079844415, 776.54572075336, 790.5454363740844, 794.8092457810142, 795.8567457857583, 796.044746304434, 796.9043714754208, 804.1476035402463, 804.6178065418909, 804.6861723927673, 805.0862271322062, 834.6119054639591, 841.2891107014593, 841.524538635672, 841.5455653946862, 842.0274582856811, 836.8744688296774, 836.9707060252862, 837.2632083766247, 837.2883049407985, 837.4472847920374, 617.728199592178, 618.0204376063944, 618.0759764152575, 618.4712071179122, 619.3280290884396, 10724.892751072468, 10849.403282819441, 10883.074938630227, 10887.292325998786, 10888.40113793741, 9097.727068187898, 9673.274504412127, 9814.46020468874, 9926.702198934043, 10203.89796102037, 8231.382646301492, 8264.21489958453, 8311.210435008665, 8326.292265157468, 8424.789380265542, 3176.9205769855707, 3236.8219747913854, 3264.836758162106, 3270.5257737627912, 3278.7868788528667, 35412.822935885415, 35938.281234375165, 39078.0, 39926.401103983466, 40311.39532907009, 9425.90574094264, 9492.810143797085, 9581.568829402693, 9710.660126895526, 9724.02759724022, 16159.757603635955, 16177.757333640006, 16193.109378984269, 16198.352065917466, 16203.594910127342, 6320.083587879823, 6407.583507072025, 6475.676216189172, 6516.609003459807, 6653.800385988428, 3427.9485807712904, 3471.218975730491, 3474.1314671332166, 3503.264314493934, 3548.3967725486727, 2705.3101459127797, 2724.6730392352647, 2725.509408306484, 2729.6451461309903, 2732.3169207698074, 477.96176305895443, 481.0139214610035, 482.3705064890282, 498.5014985014985, 501.72154454277495, 528.5164074871526, 546.3907742866754, 551.3576683164149, 562.4993755557557, 575.2263205987939, 7137.321954414322, 7183.676734546958, 7298.132768686072, 7325.2308507607, 7463.253674632493, 489.63277541843615, 574.2964868036622, 577.8526475748741, 582.4175824175824, 583.1573376471043, 3261.608606967132, 3619.0, 3861.131245469747, 3963.74235674686, 4012.9197416052098, 47815.521844781106, 49592.256116158285, 49875.501244987085, 50661.240081398806, 52165.217521737206, 44061.559384406384, 44708.77645611751, 44912.10175796466, 44937.77531112389, 45011.54988450074, 36236.27527449489, 36745.265094697956, 39520.0, 40865.387019194735, 41398.79300603538, 7514.624268786648, 7723.691052357843, 7882.448228623941, 8163.0, 8193.877091843508, 34007.31985360329, 34263.0, 34885.82557087198, 35010.0, 35030.47454288137, 43455.13089738124, 43458.78270608627, 43724.781376094186, 43966.340504891814, 44140.77929610331, 9756.219502439646, 10051.0, 10179.796404072025, 10188.898111018794, 10337.689869303633, 11691.532338706696, 11731.589394371156, 11755.412229388667, 12539.811902821282, 12542.686432838887, 10193.235507337127, 10276.383416995004, 10588.0, 10830.187735919995, 10860.837087443537, 10141.949290253502, 10266.6406675766, 10467.738306542398, 10557.102646275152, 10806.135509159405, 10113.848292275474, 10378.221633377678, 10379.221558383, 10413.583456661649, 10466.68599942003, 9394.24846012331, 9553.140217380469, 9554.187894029086, 9610.25093432974, 9959.253056020973, 9472.100150485692, 9508.952455237679, 9568.09103135201, 9579.712608621752, 9605.567749451431], "unit": "ms", "name": "yui.html", "value": 5722.288041955936}], "name": "dromaeo_css", "value": 6370.684824495262}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 111.0, 105.0, 111.0, 113.0, 112.0, 102.0, 110.0, 102.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 108.8}, {"lowerIsBetter": true, "replicates": [156.0, 128.0, 154.0, 175.0, 130.0, 154.0, 155.0, 130.0, 177.0, 130.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.9}, {"lowerIsBetter": true, "replicates": [162.0, 162.0, 161.0, 159.0, 160.0, 159.0, 161.0, 163.0, 163.0, 164.0], "unit": "ms", "name": "audio-dft", "value": 161.4}, {"lowerIsBetter": true, "replicates": [72.0, 72.0, 84.0, 92.0, 72.0, 72.0, 72.0, 96.0, 88.0, 74.0], "unit": "ms", "name": "audio-fft", "value": 79.4}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 127.0, 91.0, 91.0, 91.0, 132.0, 91.0, 92.0, 130.0], "unit": "ms", "name": "audio-oscillator", "value": 102.8}, {"lowerIsBetter": true, "replicates": [110.0, 110.0, 109.0, 110.0, 110.0, 109.0, 110.0, 110.0, 110.0, 111.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.9}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 148.0, 146.0, 147.0, 146.0, 147.0, 146.0, 147.0, 146.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.7}, {"lowerIsBetter": true, "replicates": [96.0, 96.0, 96.0, 97.0, 95.0, 95.0, 95.0, 96.0, 95.0, 96.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.7}, {"lowerIsBetter": true, "replicates": [69.0, 70.0, 70.0, 71.0, 70.0, 69.0, 69.0, 78.0, 67.0, 69.0], "unit": "ms", "name": "json-parse-financial", "value": 70.2}, {"lowerIsBetter": true, "replicates": [69.0, 71.0, 70.0, 70.0, 70.0, 69.0, 68.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 69.5}, {"lowerIsBetter": true, "replicates": [82.0, 83.0, 84.0, 84.0, 84.0, 84.0, 84.0, 86.0, 85.0, 82.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 83.8}, {"lowerIsBetter": true, "replicates": [126.0, 119.0, 117.0, 122.0, 124.0, 126.0, 124.0, 121.0, 129.0, 124.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 123.2}, {"lowerIsBetter": true, "replicates": [143.0, 136.0, 146.0, 145.0, 136.0, 136.0, 144.0, 143.0, 148.0, 133.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 141.0}, {"lowerIsBetter": true, "replicates": [69.0, 69.0, 70.0, 69.0, 68.0, 68.0, 68.0, 69.0, 70.0, 69.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.9}], "name": "kraken", "value": 1510.2}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.23865491348351], "unit": "score", "name": "Richards", "value": 216.26005200000003}, {"lowerIsBetter": false, "replicates": [192.34468166955185], "unit": "score", "name": "DeltaBlue", "value": 343.7474820000001}, {"lowerIsBetter": false, "replicates": [280.42624789680315], "unit": "score", "name": "Encrypt", "value": 949.2014460000001}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [2051.2295081967213], "unit": "score", "name": "RayTrace", "value": 360.7538781218783}, {"lowerIsBetter": false, "replicates": [791.7656373713381], "unit": "score", "name": "Earley", "value": 841.7427690000002}, {"lowerIsBetter": false, "replicates": [12500.0], "unit": "score", "name": "Boyer", "value": 53.31704}, {"lowerIsBetter": false, "replicates": [27162.162162162163], "unit": "score", "name": "RegExp", "value": 33.538751243781114}, {"lowerIsBetter": false, "replicates": [619.5786864931846], "unit": "score", "name": "Splay", "value": 131.52647400000006}, {"lowerIsBetter": false, "replicates": [4850.241545893719], "unit": "score", "name": "NavierStokes", "value": 305.9641434262948}], "name": "v8_7", "value": 19627.699583536047}]} 05:44:43 INFO - RETURN: dromaeo_css: 6370.69 05:44:43 INFO - RETURN: kraken: 1510.20 05:44:43 INFO - RETURN: v8_7: 19627.70 05:44:43 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19627.70"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1510.20"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6370.69"}}} 05:44:43 INFO - Return code: 0 05:44:43 INFO - # TBPL SUCCESS # 05:44:43 INFO - Running post-action listener: _resource_record_post_action 05:44:43 INFO - Running post-run listener: _resource_record_post_run 05:44:44 INFO - Total resource usage - Wall time: 1234s; CPU: 13.0%; Read bytes: 4096; Write bytes: 511684608; Read time: 1208; Write time: 619848 05:44:44 INFO - install - Wall time: 15s; CPU: 16.0%; Read bytes: 0; Write bytes: 188473344; Read time: 0; Write time: 266756 05:44:45 INFO - run-tests - Wall time: 1220s; CPU: 13.0%; Read bytes: 4096; Write bytes: 276029440; Read time: 1208; Write time: 231736 05:44:45 INFO - Running post-run listener: _upload_blobber_files 05:44:45 INFO - Blob upload gear active. 05:44:45 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:44:45 INFO - Copying logs to upload dir... 05:44:45 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1268.735423 ========= master_lag: 0.01 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 8 secs) (at 2015-11-20 05:44:44.891258) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 05:44:44.894505) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010085 build_url: 'https://queue.taskcluster.net/v1/task/ipyeiuzDRmigHfkWVwdBbw/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-20 05:44:44.945686) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:44:44.946100) ========= 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=c402a24d74c70935940d60dd000001de-1448023665.482229-1976504244 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004552 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 05:44:44.996335) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:44:44.996726) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 05:44:44.997165) ========= ========= Total master_lag: 0.25 =========