builder: mozilla-central_ubuntu64_hw_test-dromaeojs slave: talos-linux64-ix-045 starttime: 1448063915.39 results: success (0) buildid: 20151120143736 builduid: f2d2bb58af1b4b6bb0dbb6ee76ec236e revision: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.391717) ========= master: http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.392151) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.392457) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006535 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.419204) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.419685) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.446811) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.447184) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004574 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.496926) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.497299) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.497710) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.498120) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False --2015-11-20 15:58: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.25, 63.245.215.102 Connecting to hg.mozilla.org (hg.mozilla.org)|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 40.2M=0s 2015-11-20 15:58:35 (40.2 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.144651 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.658327) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.658610) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.021733 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.709382) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:35.709813) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e3d9cf3dc32654aaccbb9ff95930521d2b87a151 --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 e3d9cf3dc32654aaccbb9ff95930521d2b87a151 --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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 2015-11-20 15:58:35,851 truncating revision to first 12 chars 2015-11-20 15:58:35,851 Setting DEBUG logging. 2015-11-20 15:58:35,851 attempt 1/10 2015-11-20 15:58:35,851 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e3d9cf3dc326?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 15:58:36,137 unpacking tar archive at: mozilla-central-e3d9cf3dc326/testing/mozharness/ program finished with exit code 0 elapsedTime=0.563337 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:36.286556) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:36.286914) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:36.297999) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:36.298397) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 15:58:36.298893) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-20 15:58:36.299272) ========= /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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False 15:58:36 INFO - MultiFileLogger online at 20151120 15:58:36 in /builds/slave/test 15:58: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 15:58:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 15:58:36 INFO - {'append_to_log': False, 15:58:36 INFO - 'base_work_dir': '/builds/slave/test', 15:58:36 INFO - 'blob_upload_branch': 'Firefox-Non-PGO', 15:58:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 15:58:36 INFO - 'branch': 'Firefox-Non-PGO', 15:58:36 INFO - 'buildbot_json_path': 'buildprops.json', 15:58:36 INFO - 'config_files': ('talos/linux_config.py',), 15:58:36 INFO - 'default_actions': ('clobber', 15:58:36 INFO - 'read-buildbot-config', 15:58:36 INFO - 'download-and-extract', 15:58:36 INFO - 'populate-webroot', 15:58:36 INFO - 'create-virtualenv', 15:58:36 INFO - 'install', 15:58:36 INFO - 'run-tests'), 15:58:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 15:58:36 INFO - 'download_minidump_stackwalk': True, 15:58:36 INFO - 'download_symbols': 'ondemand', 15:58:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 15:58:36 INFO - 'tooltool.py': '/tools/tooltool.py', 15:58:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 15:58:36 INFO - '/tools/misc-python/virtualenv.py')}, 15:58:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 15:58:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 15:58:36 INFO - 'installer_path': 'installer.exe', 15:58:36 INFO - 'log_level': 'info', 15:58:36 INFO - 'log_name': 'talos', 15:58:36 INFO - 'log_to_console': True, 15:58:36 INFO - 'minidump_stackwalk_path': 'linux64-minidump_stackwalk', 15:58:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/linux64/releng.manifest', 15:58:36 INFO - 'opt_config_files': (), 15:58:36 INFO - 'pip_index': False, 15:58:36 INFO - 'sps_profile': False, 15:58:36 INFO - 'sps_profile_interval': 0, 15:58:36 INFO - 'suite': 'dromaeojs', 15:58:36 INFO - 'system_bits': '64', 15:58:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 15:58:36 INFO - 'title': 'talos-linux64-ix-045', 15:58:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 15:58:36 INFO - 'use_talos_json': True, 15:58:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 15:58:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 15:58:36 INFO - 'work_dir': 'build'} 15:58:36 INFO - ##### 15:58:36 INFO - ##### Running clobber step. 15:58:36 INFO - ##### 15:58:36 INFO - Running pre-action listener: _resource_record_pre_action 15:58:36 INFO - Running main action method: clobber 15:58:36 INFO - rmtree: /builds/slave/test/build 15:58:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 15:58:37 INFO - Running post-action listener: _resource_record_post_action 15:58:37 INFO - ##### 15:58:37 INFO - ##### Running read-buildbot-config step. 15:58:37 INFO - ##### 15:58:37 INFO - Running pre-action listener: _resource_record_pre_action 15:58:37 INFO - Running main action method: read_buildbot_config 15:58:37 INFO - Using buildbot properties: 15:58:37 INFO - { 15:58:37 INFO - "properties": { 15:58:37 INFO - "buildnumber": 367, 15:58:37 INFO - "product": "firefox", 15:58:37 INFO - "script_repo_revision": "production", 15:58:37 INFO - "builddir": "mozilla-central_ubuntu64_hw_test-dromaeojs", 15:58:37 INFO - "repository": "", 15:58:37 INFO - "buildername": "Ubuntu HW 12.04 x64 mozilla-central talos dromaeojs", 15:58:37 INFO - "buildid": "20151120143736", 15:58:37 INFO - "slavename": "talos-linux64-ix-045", 15:58:37 INFO - "pgo_build": "False", 15:58:37 INFO - "basedir": "/builds/slave/test", 15:58:37 INFO - "project": "", 15:58:37 INFO - "platform": "ubuntu64_hw", 15:58:37 INFO - "master": "http://buildbot-master103.bb.releng.scl3.mozilla.com:8201/", 15:58:37 INFO - "slavebuilddir": "test", 15:58:37 INFO - "scheduler": "tests-mozilla-central-linux64-talos", 15:58:37 INFO - "branch": "mozilla-central", 15:58:37 INFO - "repo_path": "mozilla-central", 15:58:37 INFO - "stage_platform": "linux64", 15:58:37 INFO - "builduid": "f2d2bb58af1b4b6bb0dbb6ee76ec236e", 15:58:37 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 15:58:37 INFO - }, 15:58:37 INFO - "sourcestamp": { 15:58:37 INFO - "repository": "", 15:58:37 INFO - "hasPatch": false, 15:58:37 INFO - "project": "", 15:58:37 INFO - "branch": "mozilla-central-linux64-talos", 15:58:37 INFO - "changes": [ 15:58:37 INFO - { 15:58:37 INFO - "category": null, 15:58:37 INFO - "files": [ 15:58:37 INFO - { 15:58:37 INFO - "url": null, 15:58:37 INFO - "name": "https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2" 15:58:37 INFO - } 15:58:37 INFO - ], 15:58:37 INFO - "repository": "", 15:58:37 INFO - "rev": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151", 15:58:37 INFO - "who": "kwierso@gmail.com", 15:58:37 INFO - "when": 1448063866, 15:58:37 INFO - "number": 6691173, 15:58:37 INFO - "comments": "Merge inbound to central, a=merge", 15:58:37 INFO - "project": "", 15:58:37 INFO - "at": "Fri 20 Nov 2015 15:57:46", 15:58:37 INFO - "branch": "mozilla-central-linux64-talos", 15:58:37 INFO - "revlink": "", 15:58:37 INFO - "properties": [ 15:58:37 INFO - [ 15:58:37 INFO - "buildid", 15:58:37 INFO - "20151120143736", 15:58:37 INFO - "Change" 15:58:37 INFO - ], 15:58:37 INFO - [ 15:58:37 INFO - "builduid", 15:58:37 INFO - "f2d2bb58af1b4b6bb0dbb6ee76ec236e", 15:58:37 INFO - "Change" 15:58:37 INFO - ], 15:58:37 INFO - [ 15:58:37 INFO - "pgo_build", 15:58:37 INFO - "False", 15:58:37 INFO - "Change" 15:58:37 INFO - ] 15:58:37 INFO - ], 15:58:37 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 15:58:37 INFO - } 15:58:37 INFO - ], 15:58:37 INFO - "revision": "e3d9cf3dc32654aaccbb9ff95930521d2b87a151" 15:58:37 INFO - } 15:58:37 INFO - } 15:58:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2. 15:58:37 INFO - Running post-action listener: _resource_record_post_action 15:58:37 INFO - ##### 15:58:37 INFO - ##### Running download-and-extract step. 15:58:37 INFO - ##### 15:58:37 INFO - Running pre-action listener: _resource_record_pre_action 15:58:37 INFO - Running main action method: download_and_extract 15:58:37 INFO - mkdir: /builds/slave/test/build/tests 15:58: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')]} 15:58:37 INFO - https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 15:58:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/test_packages.json 15:58:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/test_packages.json 15:58:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 15:58:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 15:58:41 INFO - Downloaded 1302 bytes. 15:58:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 15:58:41 INFO - Using the following test package requirements: 15:58:41 INFO - {u'common': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.cppunittest.tests.zip'], 15:58:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'jsshell-linux-x86_64.zip'], 15:58:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.mochitest.tests.zip'], 15:58:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.reftest.tests.zip'], 15:58:41 INFO - u'talos': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip'], 15:58:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.web-platform.tests.zip'], 15:58:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'], 15:58:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip', 15:58:41 INFO - u'firefox-45.0a1.en-US.linux-x86_64.xpcshell.tests.zip']} 15:58:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.linux-x86_64.common.tests.zip'] for test suite category: common 15:58:41 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')]} 15:58:41 INFO - https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:48 INFO - Downloaded 21338530 bytes. 15:58:48 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 15:58:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:48 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 15:58:49 INFO - Return code: 0 15:58:49 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 15:58: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')]} 15:58:49 INFO - https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip matches https://queue.taskcluster.net 15:58:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:50 INFO - Downloaded 21338530 bytes. 15:58:50 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 15:58:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.common.tests.zip 15:58:50 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 15:58:51 INFO - Return code: 0 15:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:51 INFO - https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip matches https://queue.taskcluster.net 15:58:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:52 INFO - Downloaded 11130997 bytes. 15:58:52 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 15:58:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.linux-x86_64.talos.tests.zip 15:58:52 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 15:58:52 INFO - Return code: 0 15:58:52 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:52 INFO - https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 matches https://queue.taskcluster.net 15:58:52 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:58:52 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:58:52 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:52 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 15:58:53 INFO - Downloaded 55899843 bytes. 15:58:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:58:53 INFO - mkdir: /builds/slave/test/properties 15:58:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 15:58:53 INFO - Writing to file /builds/slave/test/properties/build_url 15:58:53 INFO - Contents: 15:58:53 INFO - build_url:https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 15:58:53 INFO - Running post-action listener: _resource_record_post_action 15:58:53 INFO - Running post-action listener: set_extra_try_arguments 15:58:53 INFO - ##### 15:58:53 INFO - ##### Running populate-webroot step. 15:58:53 INFO - ##### 15:58:53 INFO - Running pre-action listener: _resource_record_pre_action 15:58:53 INFO - Running main action method: populate_webroot 15:58:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 15:58:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 15:58:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 15:58:53 INFO - '../fennec_ids.txt'], 15:58:53 INFO - 'tests': ['tcheck2']}, 15:58:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 15:58:53 INFO - '--tppagecycles', 15:58:53 INFO - '7'], 15:58:53 INFO - 'tests': ['tsvgm']}}, 15:58:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 15:58:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 15:58:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:58:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 15:58:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 15:58:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'tests': ['damp', 'tps']}, 15:58:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['damp', 'tps']}, 15:58:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 15:58:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 15:58:53 INFO - 'other': {'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'other_l64': {'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'other_nol64': {'tests': ['a11yr', 15:58:53 INFO - 'ts_paint', 15:58:53 INFO - 'tpaint', 15:58:53 INFO - 'sessionrestore', 15:58:53 INFO - 'sessionrestore_no_auto_restore']}, 15:58:53 INFO - 'svgr': {'tests': ['tsvgx', 15:58:53 INFO - 'tsvgr_opacity', 15:58:53 INFO - 'tart', 15:58:53 INFO - 'tscrollx', 15:58:53 INFO - 'cart']}, 15:58:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['tsvgx', 15:58:53 INFO - 'tsvgr_opacity', 15:58:53 INFO - 'tart', 15:58:53 INFO - 'tscrollx', 15:58:53 INFO - 'cart']}, 15:58:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'tests': ['tp5o']}, 15:58:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'talos_options': ['--e10s'], 15:58:53 INFO - 'tests': ['tp5o']}, 15:58:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'talos_options': ['--xperf_path', 15:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:53 INFO - 'tests': ['tp5n']}, 15:58:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 15:58:53 INFO - 'talos_options': ['--e10s', 15:58:53 INFO - '--xperf_path', 15:58:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 15:58:53 INFO - 'tests': ['tp5n']}}, 15:58:53 INFO - 'talos.zip': {'path': '', 15:58:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 15:58:53 INFO - Running post-action listener: _resource_record_post_action 15:58:53 INFO - ##### 15:58:53 INFO - ##### Running create-virtualenv step. 15:58:53 INFO - ##### 15:58:53 INFO - Running pre-action listener: _resource_record_pre_action 15:58:53 INFO - Running main action method: create_virtualenv 15:58:53 INFO - Creating virtualenv /builds/slave/test/build/venv 15:58:53 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 15:58:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 15:58:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 15:58:53 INFO - Using real prefix '/usr' 15:58:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 15:58:54 INFO - Installing distribute.............................................................................................................................................................................................done. 15:58:56 INFO - Installing pip.................done. 15:58:56 INFO - Return code: 0 15:58:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:58: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', 'pip>=1.5'] in /builds/slave/test/build 15:58: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 pip>=1.5 15:58:56 INFO - Using env: {'DISPLAY': ':0', 15:58:56 INFO - 'HOME': '/home/cltbld', 15:58:56 INFO - 'LANG': 'en_US.UTF-8', 15:58:56 INFO - 'LANGUAGE': 'en_US:en', 15:58:56 INFO - 'LOGNAME': 'cltbld', 15:58:56 INFO - 'MAIL': '/var/mail/cltbld', 15:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:56 INFO - 'MOZ_NO_REMOTE': '1', 15:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:56 INFO - 'NO_EM_RESTART': '1', 15:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:56 INFO - 'PWD': '/builds/slave/test', 15:58:56 INFO - 'SHELL': '/bin/bash', 15:58:56 INFO - 'SHLVL': '1', 15:58:56 INFO - 'TERM': 'linux', 15:58:56 INFO - 'TMOUT': '86400', 15:58:56 INFO - 'USER': 'cltbld', 15:58:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:56 INFO - '_': '/tools/buildbot/bin/python'} 15:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:56 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 15:58:56 INFO - Cleaning up... 15:58:56 INFO - Return code: 0 15:58:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 15:58: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')]} 15:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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')]} 15:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58: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', '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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:58: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', 'psutil>=0.7.1'] in /builds/slave/test/build 15:58: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 psutil>=0.7.1 15:58:56 INFO - Using env: {'DISPLAY': ':0', 15:58:56 INFO - 'HOME': '/home/cltbld', 15:58:56 INFO - 'LANG': 'en_US.UTF-8', 15:58:56 INFO - 'LANGUAGE': 'en_US:en', 15:58:56 INFO - 'LOGNAME': 'cltbld', 15:58:56 INFO - 'MAIL': '/var/mail/cltbld', 15:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:56 INFO - 'MOZ_NO_REMOTE': '1', 15:58:56 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:56 INFO - 'NO_EM_RESTART': '1', 15:58:56 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:56 INFO - 'PWD': '/builds/slave/test', 15:58:56 INFO - 'SHELL': '/bin/bash', 15:58:56 INFO - 'SHLVL': '1', 15:58:56 INFO - 'TERM': 'linux', 15:58:56 INFO - 'TMOUT': '86400', 15:58:56 INFO - 'USER': 'cltbld', 15:58:56 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:56 INFO - '_': '/tools/buildbot/bin/python'} 15:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:56 INFO - Downloading/unpacking psutil>=0.7.1 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58: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 15:58:58 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 15:58:58 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 15:58:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 15:58:58 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:58 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:58 INFO - Installing collected packages: psutil 15:58:58 INFO - Running setup.py install for psutil 15:58:58 INFO - building 'psutil._psutil_linux' extension 15:58:58 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 15:58:58 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 15:58:58 INFO - building 'psutil._psutil_posix' extension 15:58:58 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 15:58:59 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 15:58:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 15:58:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 15:58:59 INFO - Successfully installed psutil 15:58:59 INFO - Cleaning up... 15:58:59 INFO - Return code: 0 15:58:59 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:58:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:58:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:58:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:58:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:58:59 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 15:58:59 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 15:58:59 INFO - Using env: {'DISPLAY': ':0', 15:58:59 INFO - 'HOME': '/home/cltbld', 15:58:59 INFO - 'LANG': 'en_US.UTF-8', 15:58:59 INFO - 'LANGUAGE': 'en_US:en', 15:58:59 INFO - 'LOGNAME': 'cltbld', 15:58:59 INFO - 'MAIL': '/var/mail/cltbld', 15:58:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:58:59 INFO - 'MOZ_NO_REMOTE': '1', 15:58:59 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:58:59 INFO - 'NO_EM_RESTART': '1', 15:58:59 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:58:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:58:59 INFO - 'PWD': '/builds/slave/test', 15:58:59 INFO - 'SHELL': '/bin/bash', 15:58:59 INFO - 'SHLVL': '1', 15:58:59 INFO - 'TERM': 'linux', 15:58:59 INFO - 'TMOUT': '86400', 15:58:59 INFO - 'USER': 'cltbld', 15:58:59 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:58:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:58:59 INFO - '_': '/tools/buildbot/bin/python'} 15:58:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:58:59 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 15:58:59 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 15:58:59 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 15:58:59 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 15:58:59 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 15:58:59 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 15:58:59 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 15:59:01 INFO - Downloading mozsystemmonitor-0.0.tar.gz 15:59:01 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 15:59:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 15:59:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 15:59:01 INFO - Installing collected packages: mozsystemmonitor 15:59:01 INFO - Running setup.py install for mozsystemmonitor 15:59:01 INFO - Successfully installed mozsystemmonitor 15:59:01 INFO - Cleaning up... 15:59:01 INFO - Return code: 0 15:59:01 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 15:59: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')]} 15:59:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59: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')]} 15:59:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:01 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:59:01 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 15:59:01 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 15:59:01 INFO - Using env: {'DISPLAY': ':0', 15:59:01 INFO - 'HOME': '/home/cltbld', 15:59:01 INFO - 'LANG': 'en_US.UTF-8', 15:59:01 INFO - 'LANGUAGE': 'en_US:en', 15:59:01 INFO - 'LOGNAME': 'cltbld', 15:59:01 INFO - 'MAIL': '/var/mail/cltbld', 15:59:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:01 INFO - 'MOZ_NO_REMOTE': '1', 15:59:01 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:01 INFO - 'NO_EM_RESTART': '1', 15:59:01 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:01 INFO - 'PWD': '/builds/slave/test', 15:59:01 INFO - 'SHELL': '/bin/bash', 15:59:01 INFO - 'SHLVL': '1', 15:59:01 INFO - 'TERM': 'linux', 15:59:01 INFO - 'TMOUT': '86400', 15:59:01 INFO - 'USER': 'cltbld', 15:59:01 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:59:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:01 INFO - '_': '/tools/buildbot/bin/python'} 15:59:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:01 INFO - Downloading/unpacking blobuploader==1.2.4 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59: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 15:59:03 INFO - Downloading blobuploader-1.2.4.tar.gz 15:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 15:59:03 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 15:59:03 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 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 15:59:03 INFO - Downloading docopt-0.6.1.tar.gz 15:59:03 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 15:59:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 15:59:03 INFO - Installing collected packages: blobuploader, requests, docopt 15:59:03 INFO - Running setup.py install for blobuploader 15:59:03 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 15:59:03 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 15:59:04 INFO - Running setup.py install for requests 15:59:04 INFO - Running setup.py install for docopt 15:59:04 INFO - Successfully installed blobuploader requests docopt 15:59:04 INFO - Cleaning up... 15:59:04 INFO - Return code: 0 15:59:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:04 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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:59:04 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 15:59:04 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 15:59:04 INFO - Using env: {'DISPLAY': ':0', 15:59:04 INFO - 'HOME': '/home/cltbld', 15:59:04 INFO - 'LANG': 'en_US.UTF-8', 15:59:04 INFO - 'LANGUAGE': 'en_US:en', 15:59:04 INFO - 'LOGNAME': 'cltbld', 15:59:04 INFO - 'MAIL': '/var/mail/cltbld', 15:59:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:04 INFO - 'MOZ_NO_REMOTE': '1', 15:59:04 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:04 INFO - 'NO_EM_RESTART': '1', 15:59:04 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:04 INFO - 'PWD': '/builds/slave/test', 15:59:04 INFO - 'SHELL': '/bin/bash', 15:59:04 INFO - 'SHLVL': '1', 15:59:04 INFO - 'TERM': 'linux', 15:59:04 INFO - 'TMOUT': '86400', 15:59:04 INFO - 'USER': 'cltbld', 15:59:04 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:59:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:04 INFO - '_': '/tools/buildbot/bin/python'} 15:59:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Running setup.py (path:/tmp/pip-_GRAff-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Running setup.py (path:/tmp/pip-PMLjG1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Running setup.py (path:/tmp/pip-57qLa6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:04 INFO - Running setup.py (path:/tmp/pip-AVCK_G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:05 INFO - Running setup.py (path:/tmp/pip-FiPTec-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:05 INFO - Running setup.py (path:/tmp/pip-hX8Kk3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:05 INFO - Running setup.py (path:/tmp/pip-IKNRgK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:05 INFO - Running setup.py (path:/tmp/pip-O6JZ0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:05 INFO - Running setup.py (path:/tmp/pip-ElAqaD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:05 INFO - Running setup.py (path:/tmp/pip-uxnoNV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:05 INFO - Running setup.py (path:/tmp/pip-7yOXFK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:05 INFO - Running setup.py (path:/tmp/pip-Xv4xo4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Running setup.py (path:/tmp/pip-vYnGkh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Running setup.py (path:/tmp/pip-NOCJYc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Running setup.py (path:/tmp/pip-6lvd9f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Running setup.py (path:/tmp/pip-hkzszD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Running setup.py (path:/tmp/pip-UOD6Rw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:05 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 15:59:05 INFO - Running setup.py install for manifestparser 15:59:06 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozcrash 15:59:06 INFO - Running setup.py install for mozdebug 15:59:06 INFO - Running setup.py install for mozdevice 15:59:06 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing dm script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozfile 15:59:06 INFO - Running setup.py install for mozhttpd 15:59:06 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozinfo 15:59:06 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozInstall 15:59:06 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for mozleak 15:59:06 INFO - Running setup.py install for mozlog 15:59:06 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 15:59:06 INFO - Running setup.py install for moznetwork 15:59:07 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Running setup.py install for mozprocess 15:59:07 INFO - Running setup.py install for mozprofile 15:59:07 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Running setup.py install for mozrunner 15:59:07 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Running setup.py install for mozscreenshot 15:59:07 INFO - Running setup.py install for moztest 15:59:07 INFO - Running setup.py install for mozversion 15:59:07 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 15:59:07 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 15:59:07 INFO - Cleaning up... 15:59:07 INFO - Return code: 0 15:59:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 15:59:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:07 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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:59:07 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 15:59:07 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 15:59:07 INFO - Using env: {'DISPLAY': ':0', 15:59:07 INFO - 'HOME': '/home/cltbld', 15:59:07 INFO - 'LANG': 'en_US.UTF-8', 15:59:07 INFO - 'LANGUAGE': 'en_US:en', 15:59:07 INFO - 'LOGNAME': 'cltbld', 15:59:07 INFO - 'MAIL': '/var/mail/cltbld', 15:59:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:07 INFO - 'MOZ_NO_REMOTE': '1', 15:59:07 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:07 INFO - 'NO_EM_RESTART': '1', 15:59:07 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:07 INFO - 'PWD': '/builds/slave/test', 15:59:07 INFO - 'SHELL': '/bin/bash', 15:59:07 INFO - 'SHLVL': '1', 15:59:07 INFO - 'TERM': 'linux', 15:59:07 INFO - 'TMOUT': '86400', 15:59:07 INFO - 'USER': 'cltbld', 15:59:07 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:59:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:07 INFO - '_': '/tools/buildbot/bin/python'} 15:59:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 15:59:07 INFO - Running setup.py (path:/tmp/pip-mN5f2R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 15:59:08 INFO - Running setup.py (path:/tmp/pip-pxY1CS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 15:59:08 INFO - Running setup.py (path:/tmp/pip-sKgGsa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 15:59:08 INFO - Running setup.py (path:/tmp/pip-E6zQtm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 15:59:08 INFO - Running setup.py (path:/tmp/pip-OEJkFT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 15:59:08 INFO - Running setup.py (path:/tmp/pip-lkiFz6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 15:59:08 INFO - Running setup.py (path:/tmp/pip-0ZjJmj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 15:59:08 INFO - Running setup.py (path:/tmp/pip-4UiLRC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 15:59:08 INFO - Running setup.py (path:/tmp/pip-jZFO3m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 15:59:08 INFO - Running setup.py (path:/tmp/pip-oRZ9M0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 INFO - Running setup.py (path:/tmp/pip-_VjaJK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 15:59:08 INFO - Running setup.py (path:/tmp/pip-KXxWRr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 15:59:08 INFO - Running setup.py (path:/tmp/pip-UL08sO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 15:59:08 INFO - Running setup.py (path:/tmp/pip-lia_N3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 15:59:08 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)) 15:59:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:08 INFO - Running setup.py (path:/tmp/pip-lxTYud-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 15:59:09 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)) 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 15:59:09 INFO - Running setup.py (path:/tmp/pip-m3S2wL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 15:59:09 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)) 15:59:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 15:59:09 INFO - Running setup.py (path:/tmp/pip-YKfiJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 15:59:09 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)) 15:59:09 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)) 15:59:09 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)) 15:59:09 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)) 15:59:09 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)) 15:59:09 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)) 15:59:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 15:59:09 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 15:59:09 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 15:59:09 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 15:59:09 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 15:59:09 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 15:59:09 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 15:59:10 INFO - Downloading blessings-1.5.1.tar.gz 15:59:10 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 15:59:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 15:59:10 INFO - Installing collected packages: blessings 15:59:10 INFO - Running setup.py install for blessings 15:59:11 INFO - Successfully installed blessings 15:59:11 INFO - Cleaning up... 15:59:11 INFO - Return code: 0 15:59:11 INFO - Done creating virtualenv /builds/slave/test/build/venv. 15:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:11 INFO - Reading from file tmpfile_stdout 15:59:11 INFO - Current package versions: 15:59:11 INFO - argparse == 1.2.1 15:59:11 INFO - blessings == 1.5.1 15:59:11 INFO - blobuploader == 1.2.4 15:59:11 INFO - docopt == 0.6.1 15:59:11 INFO - manifestparser == 1.1 15:59:11 INFO - mozInstall == 1.12 15:59:11 INFO - mozcrash == 0.16 15:59:11 INFO - mozdebug == 0.1 15:59:11 INFO - mozdevice == 0.47 15:59:11 INFO - mozfile == 1.2 15:59:11 INFO - mozhttpd == 0.7 15:59:11 INFO - mozinfo == 0.9 15:59:11 INFO - mozleak == 0.1 15:59:11 INFO - mozlog == 3.0 15:59:11 INFO - moznetwork == 0.27 15:59:11 INFO - mozprocess == 0.22 15:59:11 INFO - mozprofile == 0.27 15:59:11 INFO - mozrunner == 6.11 15:59:11 INFO - mozscreenshot == 0.1 15:59:11 INFO - mozsystemmonitor == 0.0 15:59:11 INFO - moztest == 0.7 15:59:11 INFO - mozversion == 1.4 15:59:11 INFO - psutil == 3.1.1 15:59:11 INFO - requests == 1.2.3 15:59:11 INFO - wsgiref == 0.1.2 15:59:11 INFO - Installing None into virtualenv /builds/slave/test/build/venv 15:59:11 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')]} 15:59:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 15:59:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:11 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')]} 15:59:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 15:59:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 15:59:11 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 0x7f2ac9187c70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x13c66c0>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1477900>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, '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': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', '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 15:59:11 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 15:59:11 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 15:59:11 INFO - Using env: {'DISPLAY': ':0', 15:59:11 INFO - 'HOME': '/home/cltbld', 15:59:11 INFO - 'LANG': 'en_US.UTF-8', 15:59:11 INFO - 'LANGUAGE': 'en_US:en', 15:59:11 INFO - 'LOGNAME': 'cltbld', 15:59:11 INFO - 'MAIL': '/var/mail/cltbld', 15:59:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:11 INFO - 'MOZ_NO_REMOTE': '1', 15:59:11 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:11 INFO - 'NO_EM_RESTART': '1', 15:59:11 INFO - 'PATH': '/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:11 INFO - 'PWD': '/builds/slave/test', 15:59:11 INFO - 'SHELL': '/bin/bash', 15:59:11 INFO - 'SHLVL': '1', 15:59:11 INFO - 'TERM': 'linux', 15:59:11 INFO - 'TMOUT': '86400', 15:59:11 INFO - 'USER': 'cltbld', 15:59:11 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:59:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:11 INFO - '_': '/tools/buildbot/bin/python'} 15:59:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 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)) 15:59:11 INFO - Cleaning up... 15:59:11 INFO - Return code: 0 15:59:11 INFO - Running post-action listener: _resource_record_post_action 15:59:11 INFO - Running post-action listener: _start_resource_monitoring 15:59:11 INFO - Starting resource monitoring. 15:59:11 INFO - ##### 15:59:11 INFO - ##### Running install step. 15:59:11 INFO - ##### 15:59:11 INFO - Running pre-action listener: _resource_record_pre_action 15:59:11 INFO - Running main action method: install 15:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 15:59:11 INFO - Reading from file tmpfile_stdout 15:59:11 INFO - Detecting whether we're running mozinstall >=1.0... 15:59:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 15:59:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 15:59:11 INFO - Reading from file tmpfile_stdout 15:59:11 INFO - Output received: 15:59:11 INFO - Usage: mozinstall [options] installer 15:59:11 INFO - Options: 15:59:11 INFO - -h, --help show this help message and exit 15:59:11 INFO - -d DEST, --destination=DEST 15:59:11 INFO - Directory to install application into. [default: 15:59:11 INFO - "/builds/slave/test"] 15:59:11 INFO - --app=APP Application being installed. [default: firefox] 15:59:11 INFO - mkdir: /builds/slave/test/build/application 15:59:11 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'] 15:59:11 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 15:59:25 INFO - Reading from file tmpfile_stdout 15:59:25 INFO - Output received: 15:59:25 INFO - /builds/slave/test/build/application/firefox/firefox 15:59:25 INFO - Running post-action listener: _resource_record_post_action 15:59:25 INFO - ##### 15:59:25 INFO - ##### Running run-tests step. 15:59:25 INFO - ##### 15:59:25 INFO - Running pre-action listener: _resource_record_pre_action 15:59:25 INFO - Running main action method: run_tests 15:59:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 15:59:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 15:59:25 INFO - Python 2.7.3 15:59:25 INFO - Return code: 0 15:59:25 INFO - grabbing minidump binary from tooltool 15:59:25 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')]} 15:59:25 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 0x14bdb70>, '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 0x150edc0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x150f250>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 15:59:25 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 15:59:25 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 15:59:26 INFO - INFO - File linux64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 15:59:26 INFO - Return code: 0 15:59:26 INFO - Chmoding /builds/slave/test/build/linux64-minidump_stackwalk to 0755 15:59:26 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 15:59:26 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 15:59:26 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/linux64-minidump_stackwalk 15:59:26 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 15:59:26 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/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] in /builds/slave/test/build 15:59:26 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/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip --title talos-linux64-ix-045 --webServer localhost 15:59:26 INFO - Using env: {'DISPLAY': ':0', 15:59:26 INFO - 'HOME': '/home/cltbld', 15:59:26 INFO - 'LANG': 'en_US.UTF-8', 15:59:26 INFO - 'LANGUAGE': 'en_US:en', 15:59:26 INFO - 'LOGNAME': 'cltbld', 15:59:26 INFO - 'MAIL': '/var/mail/cltbld', 15:59:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 15:59:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/linux64-minidump_stackwalk', 15:59:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 15:59:26 INFO - 'MOZ_NO_REMOTE': '1', 15:59:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 15:59:26 INFO - 'NODE_PATH': '/usr/lib/nodejs:/usr/lib/node_modules:/usr/share/javascript', 15:59:26 INFO - 'NO_EM_RESTART': '1', 15:59:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/bin:/usr/local/bin:/usr/bin:/bin:/usr/local/games:/usr/games', 15:59:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 15:59:26 INFO - 'PWD': '/builds/slave/test', 15:59:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 15:59:26 INFO - 'SHELL': '/bin/bash', 15:59:26 INFO - 'SHLVL': '1', 15:59:26 INFO - 'TERM': 'linux', 15:59:26 INFO - 'TMOUT': '86400', 15:59:26 INFO - 'USER': 'cltbld', 15:59:26 INFO - 'XDG_SESSION_COOKIE': '61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299', 15:59:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 15:59:26 INFO - '_': '/tools/buildbot/bin/python'} 15:59:26 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/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.crashreporter-symbols.zip', '--title', 'talos-linux64-ix-045', '--webServer', 'localhost'] with output_timeout 3600 15:59:26 INFO - mozversion INFO | application_buildid: 20151120143736 15:59:26 INFO - mozversion INFO | application_changeset: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 15:59:26 INFO - mozversion INFO | application_display_name: Nightly 15:59:26 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 15:59:26 INFO - mozversion INFO | application_name: Firefox 15:59:26 INFO - mozversion INFO | application_remotingname: firefox 15:59:26 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 15:59:26 INFO - mozversion INFO | application_vendor: Mozilla 15:59:26 INFO - mozversion INFO | application_version: 45.0a1 15:59:26 INFO - mozversion INFO | platform_buildid: 20151120143736 15:59:26 INFO - mozversion INFO | platform_changeset: e3d9cf3dc32654aaccbb9ff95930521d2b87a151 15:59:26 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 15:59:26 INFO - mozversion INFO | platform_version: 45.0a1 15:59:26 INFO - 2015-11-20 15:59:26,177 DEBUG : using testdate: 1448063966 15:59:26 INFO - 2015-11-20 15:59:26,177 DEBUG : actual date: 1448063966 15:59:26 INFO - 2015-11-20 15:59:26,225 INFO : starting webserver on 'localhost:52263' 15:59:26 INFO - 2015-11-20 15:59:26,226 INFO : Starting test suite talos-linux64-ix-045 15:59:26 INFO - 2015-11-20 15:59:26,226 INFO : Starting test dromaeo_css 15:59:26 INFO - 2015-11-20 15:59:26,226 DEBUG : operating with platform_type : linux_ 15:59:26 INFO - 2015-11-20 15:59:26,227 INFO : Initialising browser for dromaeo_css test... 15:59:26 INFO - 2015-11-20 15:59:26,237 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZxCS5/profile http://localhost:52263/getInfo.html 15:59:31 INFO - 2015-11-20 15:59:31,650 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 15:59:31 INFO - 2015-11-20 15:59:31,650 DEBUG : BROWSER_OUTPUT: colorDepth:24 15:59:31 INFO - 2015-11-20 15:59:31,650 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 15:59:31 INFO - 2015-11-20 15:59:31,650 DEBUG : BROWSER_OUTPUT: __metrics 15:59:31 INFO - 2015-11-20 15:59:31,771 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 15:59:33 INFO - 2015-11-20 15:59:33,058 INFO : Browser initialized. 15:59:33 INFO - 2015-11-20 15:59:33,058 INFO : Running cycle 1/1 for dromaeo_css test... 15:59:33 INFO - 2015-11-20 15:59:33,058 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp3ZxCS5/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 15:59:44 INFO - 2015-11-20 15:59:44,940 DEBUG : BROWSER_OUTPUT: RSS: Main: 142364672 15:59:44 INFO - 2015-11-20 15:59:44,940 DEBUG : BROWSER_OUTPUT: 16:00:36 INFO - 2015-11-20 16:00:36,138 DEBUG : BROWSER_OUTPUT: 1448064036137 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 16:02:47 INFO - 2015-11-20 16:02:47,935 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-dojo.html (next: http://localhost:52263/tests/dromaeo/cssquery-ext.html) 16:02:49 INFO - 2015-11-20 16:02:49,193 DEBUG : BROWSER_OUTPUT: RSS: Main: 223141888 16:02:49 INFO - 2015-11-20 16:02:49,193 DEBUG : BROWSER_OUTPUT: 16:05:51 INFO - 2015-11-20 16:05:51,667 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-ext.html (next: http://localhost:52263/tests/dromaeo/cssquery-jquery.html) 16:05:52 INFO - 2015-11-20 16:05:52,240 DEBUG : BROWSER_OUTPUT: RSS: Main: 219955200 16:05:52 INFO - 2015-11-20 16:05:52,240 DEBUG : BROWSER_OUTPUT: 16:08:54 INFO - 2015-11-20 16:08:54,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-jquery.html (next: http://localhost:52263/tests/dromaeo/cssquery-mootools.html) 16:08:54 INFO - 2015-11-20 16:08:54,892 DEBUG : BROWSER_OUTPUT: RSS: Main: 211369984 16:08:54 INFO - 2015-11-20 16:08:54,892 DEBUG : BROWSER_OUTPUT: 16:11:56 INFO - 2015-11-20 16:11:56,827 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-mootools.html (next: http://localhost:52263/tests/dromaeo/cssquery-prototype.html) 16:11:57 INFO - 2015-11-20 16:11:57,421 DEBUG : BROWSER_OUTPUT: RSS: Main: 199962624 16:11:57 INFO - 2015-11-20 16:11:57,421 DEBUG : BROWSER_OUTPUT: 16:15:00 INFO - 2015-11-20 16:15:00,195 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-prototype.html (next: http://localhost:52263/tests/dromaeo/cssquery-yui.html) 16:15:00 INFO - 2015-11-20 16:15:00,796 DEBUG : BROWSER_OUTPUT: RSS: Main: 205922304 16:15:00 INFO - 2015-11-20 16:15:00,796 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,434 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/dromaeo/cssquery-yui.html (next: http://localhost:52263/tests/dromaeo/cssquery-dojo.html) 16:18:03 INFO - 2015-11-20 16:18:03,692 DEBUG : BROWSER_OUTPUT: RSS: Main: 250580992 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2657.667791526059;2728.3588356736163;2731.3035176030107;2741.109139529652;2757.2141939547228;4464.464264288282;4607.562281583253;4620.168369693454;4625.028743963768;4638.443386793581;4567.611753000991;4571.51999040101;4590.013147173357;4662.160811054009;4667.929981050287;4250.2137104635585;4278.657707383401;4286.078493123978;4289.528151903296;4332.0469496710675;4097.692673049518;4288.828446862121;4297.763623000734;4343.283358245902;4362.367456718774;4183.142455796555;4250.702450828443;4268.59448352406;4274.166537525184;4286.592773686495;4282.379055037033;4326.935095973531;4338.370936214231;4370.2133615949115;4373.409589705381;4066.1867626474527;4305.117450922553;4317.395564620955;4326.480822301312;4371.191329604034;4515.254982927813;4518.932216016762;4569.1318649456825;4676.859694209179;4705.411823522059;5003.049420610072;5027.622928280357;5037.823676171316;5037.949620503821;5075.5178258065425;4760.214564596838;5031.1950087986115;5042.168042273021;5048.318477005594;5049.116404629175;4595.218812801765;4626.398568186148;4645.976770116128;4666.300054991711;4702.788374523155;5129.769160387791;5153.072446959583;5157.63896527247;5163.277141200235;5163.66436181647;4959.70241785494;4959.801607935714;4960.355153829979;4994.500549944976;5008.398992120896;4739.099571081552;4858.149823780895;4858.368412106403;4861.586765124934;4971.055499455092;4993.375828021497;5008.899822003539;5009.774560144802;5019.196928491424;5059.696418214919;4972.925406118911;4980.576650984707;4983.451820299764;4986.202207646832;5029.06962211992;3992.7005474589523;4048.8987775305854;4089.3252613319064;4090.447789548373;4098.344264917599;3596.5684117906017;3621.5654121505063;3668.963310366862;3681.042928838521;3706.3513885070543;4264.530901600821;4265.50946641134;4283.957160428418;4293.141371725667;4321.027768752006;4982.252662100642;4987.376577927759;4991.575716064175;4993.6005119590345;5037.848864534069;4138.213739389506;4224.852130175429;4239.491261048694;4244.257254980366;4326.459192600925;4464.888377790581;4482.8655140345845;4488.5960263576435;4489.079738653568;4528.45658520973;4800.279958006327;4802.351682522954;4805.471398146131;4807.855764327076;4846.442659094178;4797.712137271775;4815.759212039454;4903.975480122719;4909.803607855646;4912.435069966999;4771.093492236464;4793.640476964172;4798.160321943716;4798.712077275374;4803.063402636452;4980.900381992267;4982.402111746614;4987.0524600325825;4993;5021.447640759587;4709.222978208557;4879.170541007966;4881;5044.571211446922;5093.414257360303;4802.51974802517;4810.374651295309;4832.106060378841;4919.114559379203;4932.1122198004705;4916.483769204182;4935.136351138608;4937.802487900443;4945.060438516671;4986.376702912136;4594.2419500782;4819.6867203631655;4843.539863712942;4845.466998630219;4847.297141914332;4736.8578942631775;4737.265723812815;4758.405199350082;4828.782704778223;4849.709017458823;4755.524447555217;4792.616590672668;4821.566059054702;4822.903541929071;4863.367762190893 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: |1;ext.html;562.5640128900102;565.1043096691743;566.7591273708673;574.5030548575484;576.2479963647442;28245.293867653294;28994;37060.62939370609;37784.81107594465;37865.24269514608;40962.59037409625;41010.7949460253;41260.58739412605;41314;41391.58608413915;7011.544249623758;7147.2138064812825;7839.451238413313;8001.319887809544;8001.799955001114;10220.284580079397;10466.842997355046;10470.842937355947;10476.947615261914;10480.737981550485;10035.29752917296;10117.14004309631;10118.089371956523;10124.088832005118;10129.088382045615;7210;7399.408047356253;7406.296401841816;7410.407167426647;10060.597576096947;10235;10484.58061677532;10485.21360897928;10501.4224217668;10501.579936802518;37501.62498375036;37869.621303787164;38089;38091.619083809084;38094;2900.274931267183;2905.941881162386;2953.1731115287753;3517.9648203517895;3602.189507360849;28553;28573.714262857313;28832.279193020342;29252.41495170106;29505.262368440744;3433.1931995980926;3450.8102054387;3464.7747896386654;3506.8421921013614;3588.3899737044767;225446;225845;226890;227610;227918;51550;52447.73776131095;52537;55480.72259638676;55852.44147558554;47187.34844280434;47304.290435643496;66038.66980665067;68216;68288.6585567069;13440.865591344156;13561.321933903266;13600.93199533996;13604.251766152758;13671.248081355421;9914;10011.349262297927;10045.69862904114;10057.044580764816;10059.245556583286;19082.236710531703;19168.61662766737;19211.423657290303;19237.326693565938;19269.61460770805;7277.19950805411;7507.324340809353;7610.581418021951;7646.4265180111715;7736.187700291501;835.4569529805675;860.7848037990502;890.808476177612;919.1589695428742;1030.1295405382439;26379.472410552065;26505.33736656599;26688;26784.464310713676;26964.865175673996;934.7709811096325;948.8102379524123;976.9462679552693;988.1403179233969;996.5515518016921;13700.794488082687;13784.241866697228;14138.363773630212;14140.292985350692;14163.64590885236;273513;278823;279265;279849;280596;45791.77104114458;46121.308180377324;46152;46157;46159.30761038587;1226.1845872494869;1227.969300767488;1234.3766397969148;1237.55448038706;1243.2726854790048;23399.76600234044;24991.250262492154;25934.610980834925;26458.470830583665;26582;38919.610803892734;39264.2147157061;39281.803590981865;39341.40987885241;39424.802875985435;215149;217474;219053;220056;220621;24867.62698559559;25329.240122796346;27561.58657620097;29154.854225728737;30437.391252175275;37546;37847.81076094602;37913.810430948775;38356.80821595874;38468;32165.195870103435;32691;32743.18142046468;33304;33507.66492335143;27151.45697086087;29482.557761634023;32379.838100810288;33016;33178;32762.50856237206;32850.83574582112;33186.50220246746;33196.174210417696;33276.1680957978;27476.725232747416;29663.85168074146;29825.552616710334;29870.25324366908;29921.873828482523;22818;23143.421414464774;23580.764192357856;23609.93755280982;23633.763662363155 16:18:03 INFO - 2015-11-20 16:18:03,693 DEBUG : BROWSER_OUTPUT: |2;jquery.html;331.49281599153306;334.4080976671292;335.35611625678695;335.3862431749898;337.2142907026628;12450.750984980317;12721.17312374695;14792.260386980663;15151.621209469755;15766.605834854148;9700.369475984056;9796.412215267072;10024.799504009916;10071.244656650762;10122.493875306242;4523.276275795865;4651.093036857814;4651.186042442576;4651.232546629819;4654.557817007379;3386.4412371958597;3491.8952431427097;5173.818916337929;5355.544778693797;5360.035193665139;5287.048331300364;5321.361436627591;5324.7071411072375;5325.201219817039;5340.439253878345;5243.580513558906;5370.731463426852;5402.837914862561;5404.486573775524;5406.135018397057;5105.463926287761;5202.167653175474;5206;5219.921701174486;5221;18133.909330453396;18285.725714114298;18598.62802743951;18622.16200270991;18783.718244226347;1754.6929287374658;1819.6542656895147;1819.7543331650322;1822.280199321274;1885.9151338189815;8976.192142707123;9145.954270228607;9267;11233.32600044;12498.062645301548;1669.4323929863904;1672.874534409912;1715.0995727243173;1718.1021426620725;1778.0487439220085;46290.5370946293;47459;50029.24956125661;51745.48254517482;53159.734201329135;9295.953520232355;9525.428474291564;9535.52322383892;9645.131938125462;9718.805623887483;12199.329036903055;12214.816777748341;12220.75558488843;12227.388630568435;12236.694082647828;6727.562708424035;6736.1916570010935;6789.083473730983;6810.795676129724;6836.111305530249;6243.125962365272;6262;6287.937120628827;6304.369563043659;6407.391297826699;4051.534073581517;4110.753354798721;4121.670266378683;4138.937915931264;4141.503019637663;1562.2579274844586;1626.3413317606153;1636.6972110159659;1699.6430749542735;1701.5575950253024;372.2907860525703;846.5597889097635;928.8699582058517;977.0327375897951;987.110783512971;8939.374243802871;9267.907320926704;9558.952205239068;9828.950855245821;9863.260255480867;354.2507596433576;406.92471892699945;407.3279089502345;414.5460720511036;428.83061190830074;5342.732863356817;5655.773769049192;5682.119271512922;5724.570657200727;5726.312842458931;497252;506215;513517;519613;526209;67853;68943;70094.29905700877;70393.64803175951;70638.29361706317;1067.0449947297125;1078.7087486378791;1108.130117857478;1144.2219290882113;1144.719543711796;14119.64700882486;14459.493917712829;14485.493007744679;14508.429542311313;14523.636909077357;22059.66910496376;24340.634890476304;28633.28416789597;29125.7087429123;29812.552811707406;38986.22027559376;39358.409623856234;39410.40884386679;39790;41503;8467.49195048299;8657.696980605648;8682.262007729161;8827.955860220658;8883;15682;15737.921310393374;15777.921110394374;15995.280212390238;16035.438759643357;12946.352682365656;13203.273819939996;13300;13376;13475.865241347461;11955.880441195477;12167.634970950885;12597.937010315256;12609.43257553394;12719.55481558141;12749.17130386522;13033.283169425773;13327.466901323838;13453.260070695815;13559.118657287245;8740.650373984969;8766.605502752263;8778.078301778221;8839.027706952358;8845.646174152962;9268.443893366419;12957.870421295667;13689.589312320646;13869.653258668613;14330.355134019203 16:18:03 INFO - 2015-11-20 16:18:03,695 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1449.058112227053;1623.2451909861911;1669.8998060116394;1694.8898321609101;1699.0570233520396;5656.745446454909;6528.4777217822575;6683.398494135533;6684.064231007651;6685.765998190064;6526.216853977529;6609.504287178457;6617.437517810992;6623.735050597982;6632.336766323365;2001.8498612604076;2021.6361055010093;2021.7674967378719;2023.8380929525676;2025.1696804310236;2033.8372930165626;2040.3776848061336;2042.428120126367;2069.9793002069937;2077.511784730587;2022.100165426386;2044.5195379085978;2045.509077821327;2058.763242227148;2059.3513043391285;2001.7798042215345;2007.2673474181966;2010.829079528242;2012.0442789674933;2014.446027342478;2029.7056926745686;2041.5202427429542;2071.8860462674547;2073.7200477935435;2079.2618620389694;5584.106542953149;5759.68321742304;6544.280129185786;6555.737770489175;6579.539432239745;3874.438206460076;3964.5837187095517;3967.682585393162;3986.7009974252046;3996.3406038003695;2607.478504299129;2629.1718108795667;2652.7082020977678;2659.4548117635836;2759.4756996170863;892.5938697892443;895.4627223665749;902.566767951387;921.5530467723149;925.5834874306522;8839;8907.821843563157;8924.955375223148;8925.107489251088;8941.150590693938;3792.1467669774634;3805.486259355007;3842.6742773743013;3847.153626202231;3850.5956874528333;7757.534547927143;7775.805604859811;7778.572178530122;7780.533168009937;7780.533168009937;4051;4051.736637118578;4054.412110244057;4056.290149223933;4056.9797151014645;3686.1153323202775;3688.280785246851;3689.5019172411917;3690.5202323698286;3695.796731179757;3238.3847069056806;3245.1075954112807;3249.9837500812346;3252.10567094051;3280.425925463034;1072.8337107748312;1084.203110713625;1099.8020356335776;1110.5724296145881;1111.2110401614782;900.5407242306339;980.5734505490135;1150.5225331487507;1165.0155618502522;1170.5083864776814;5971;5977.372375900555;6005.909911351333;6066.514678825683;6067.150598916155;999.7550600103021;1028.4446398944635;1032.055669062814;1038.9116925061455;1042.8696412948382;4576.382188404589;5033.395992480926;5073.340465739504;5073.365829271341;5078.289039534468;6810.080639113756;7569.167391586921;7838.941742864754;7852.154743635241;7873.212678732081;7670.386369090459;7696.884546731803;7733.188015258429;7737.342325902248;7749.651265693057;6091.329953705089;6360.491160707133;6376.968115159394;6392.488600912009;6401.615903045832;6351.555391122577;6381.266154392304;6384.521160912857;6396.200474940632;6399.55203135776;6984.650767461708;7164.641767911688;7241.493095483265;7249.492535522463;7266.600336981517;7251.23861994483;7408.296211859864;7448.5158464699625;7450.254974502506;7457.179710231979;5637.577181711306;5673.631213971079;5676.4323567642905;5686.43135686428;5700.686462244616;5813.215215945793;6032.517398608188;6050.485708714808;6056.636601803906;6083.574149809471;5937.495312898279;5952.642841429528;6051.273847138195;6160;6191.473724733448;5852.385499522659;5958.1658567801405;5968.612040217372;6008.519318454601;6012.579119461596;5850.64896106235;5985.700714964321;6089.725962331794;6152.50779937595;6177.505799536116;5621.128725047624;5651.632643878134;5653.745581448927;5656.010198215378;5656.038473459604;5460.34475862899;5477.096279113902;5490.80782172622;5499.2576002240785;5501.449855014466 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: |4;prototype.html;300.98645560949757;308.0650226562382;309.66092129118624;309.91477343730486;311.22349737405176;5100.591952643789;5210.869728256791;5218.5564227040695;5285.365756109262;5306.230596563496;5099.413567439746;5115.360579927509;5224.764885580148;5228.92156617651;5234.947650523493;3927.0771368728324;4073.083556199846;4073.5926407359325;4115.8971025724295;4117.69117316201;4036.8385264589383;4039.212353591051;4041.1513582147636;4043.4541336919433;4043.575424580421;4014.899627509321;4087.2438598859308;4123.443335149746;4125.587441255881;4131.607497287753;4117.69117316201;4119.299719047769;4125.154343359619;4125.5874412558505;4128.772917489537;3651.543557055368;3651.561812582507;3657.7622454540638;3662.6703596676425;3662.853485860562;4946.554810067075;5101.846944591631;5118.104331741967;5145.331106956071;5155.329807125087;4769.308450274725;4773.140834649762;4780.043991201774;4781.426228852525;4784.067106914154;5350.438203988564;5573.359063707685;5618;5626.437356264381;5629.043062679354;3893.5911729268587;3895.9805200973815;4008.118213992946;4012.197560487914;4020.9396859047138;5758.3090029196765;5830.7959221427045;5841.386654401269;5853.443922827325;5855.385184555603;4128.855490057834;4133.132042271157;4134.524529679065;4135.875923722293;4136.131412403369;4107.609777071173;4188.623023927861;4196.328587425997;4196.874093777192;4198.5591512891315;4737.218358970731;4750.311204875343;4750.714957102585;4753.500882407367;4756.405449318835;5561.138023606267;5561.5272701820795;5562.582806289544;5564.165375193672;5566.526845218202;1467;1483.2954346685237;1485.89598728088;1486;1487.152323175801;981.2297346582898;1018.022698209727;1020.9030142136485;1026.3328836256494;1043.5251960358019;4882.6826256293225;4885.2427873679635;4890.364252647204;4891.853244402673;4896.828610998669;5766.567507436959;5771.567132465082;5792.044312688444;5794.5364370851075;5805.622634528742;4896.290037944478;4901.485344038824;4902.852914412502;4906.165951788204;4909.631777616693;3051.969480305213;3097.90706278812;3118.4075025745037;3125.390548842999;3132.4674805283157;5532.75102620375;5533.114701647717;5543.722813859291;5544.528715059185;5550.972245138829;5985.22192115031;6010.128531363015;6011.158437818709;6012.128241404972;6013.609115407485;5529.806456773994;5532.336119665666;5536.141898005815;5536.446355364431;5537.335519737577;5690.573207009408;5854.677992710442;5857.882842343214;5858.794942177004;5861.912071319019;5492.258545096361;5610.102383618601;5613.607047506635;5615.6630602164005;5617.8033768817895;5390.272313237662;5437.592180586551;5523.337199536081;5535.0590399632965;5536.4186760389575;3989.8005099744314;4007.859724909614;4016.5380981187536;4017.216642754635;4019.919601607893;5676.943230567642;5818.156367326629;5822.7670893163795;5826.126081087701;5828.737706803119;5594.188842617879;5598.300212473441;5602.3837377887585;5603.831885043455;5607.747651355618;5590.776368945197;5600.383957764724;5601.663900166003;5604.047311957059;5607.383187849415;5492.972535137299;5494.560435165097;5501.339839219159;5502.202180683858;5508.366537848199;5477.233187353694;5630.465105814941;5669.922714684197;5675.858103547444;5683.318001839641;5522.6134170607675;5530.5022547970875;5535.169724541351;5538.667679939216;5542 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: |5;yui.html;683.3542302524114;704.9295070492951;734.5262305812751;770.8689522781127;819.1112642782581;11186.720331991693;11355.432228388569;11364.147688923344;11376.317420954749;11378.431078446076;11468.311901285908;11469.369184694839;11474.024707899818;11638.127140464456;11833.349165795878;623.9906401403982;630.5271046714964;779.9844003119935;785.077533897668;797.4497596658316;788.7160622176012;797.9401544884128;802.2859654907137;802.5064585280069;803.461680673947;823.7405217356544;827.1934863508092;827.7516744976483;828.1883753921161;828.2421584250434;645.8514541655422;652.1098700274115;819.692615269277;830.0993422136988;831.0193971114084;615.7260019291417;616.8951278282658;618.0296933813914;620.3145524195744;622.7975907829973;10775;10822.512986915608;10881.455927203608;10888;10952.671419857417;10452.843207351896;11803.822942655866;11909.285442873368;11958.40207989597;12032.097592680497;9286.257099432029;9303.72088837336;9330.67342643011;9345.906540934571;9428.90571094294;3314.552535407713;3317.402867483852;3340.3987282289177;3362.697357237836;3374.308266805299;41334.58665413367;41379.7931010346;41820.372694409605;42313;42353.57646423527;9444.386114902509;9466.242700583936;9480.573374198178;9488.95255523718;9508.477033763209;16466.6706665866;16621.252043658063;16628.33486660544;16657;16682.332706691595;6355.046742988588;6427.357264273535;6437.227532696106;6437.871242575122;6670.866582668319;3633.7274704397278;3653.7442379033746;3675.61406052366;3680.723945704083;3763.1532905096683;2673.0777881630806;2675.1305825606755;2701.2031450722084;2705.1208357283963;2707.0931238035087;476.1738383903924;482.4765129834099;482.99054975102206;485.09045539613226;489.1317910708521;477.6560876169222;524.8687828042989;613.9140520327069;630.486153784664;637.512303088138;7739.845203095907;7889.09275433321;7936.2857342839425;8408.41141120128;8546.572671366406;501.4859768737074;594.7234535940809;599.8890205312031;605.8485378655337;606.3542327421283;3783.281176576442;3838.808059597065;3852.1332700142802;3901.200253947934;3936.7637941723588;48499.75750121227;49899.25151122736;54232;54831;55289;44281.778591106835;45295.77352113284;45568.3164752529;45721;45808.541914580426;41805.1638967219;42103.842211834235;42700;42794.14411711811;42813.35779963303;8053.758387248392;8434.390043149824;8451.704190353308;8498.872516912128;8512.659493620433;31534.842325788224;31679.36641267208;31970.6802931977;32441.837790810896;33126.834365828014;36635;37120.814395927846;39465;41149.79425102855;41171.58828411797;9356.906430935876;10217.897821021694;10308.278420510493;10394.792104158027;10404.271700980858;10515.842262365917;10715.935793808827;10874.293170943864;11059.281146725438;11148.386838723623;10968;10983.340999540053;10992.670219893416;11034.337939723642;11065.336079835235;10271.537780800032;10380.584776608852;10650.786984260427;10766.407847568458;10772.461376930965;9883.11052005323;9906.900930990598;10238.590456381662;10573.418461984666;10968.17738669587;9052.463138644333;9252.676156334495;9296.280989677916;9430.669926552811;9451.78639262654;8741.125887411463;8794.956025219833;8820.382573219813;9131.990961988351;9473.905260947578 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1092 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: __startTimestamp1448065083686__endTimestamp 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,696 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:18:03 INFO - 2015-11-20 16:18:03,697 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:18:03 INFO - 2015-11-20 16:18:03,697 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,697 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4603.82 Median:4760.21 stddev:481.40 (10.1%) stddev-sans-first:458.03 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: Values: 2657.7 2728.4 2731.3 2741.1 2757.2 4464.5 4607.6 4620.2 4625.0 4638.4 4567.6 4571.5 4590.0 4662.2 4667.9 4250.2 4278.7 4286.1 4289.5 4332.0 4097.7 4288.8 4297.8 4343.3 4362.4 4183.1 4250.7 4268.6 4274.2 4286.6 4282.4 4326.9 4338.4 4370.2 4373.4 4066.2 4305.1 4317.4 4326.5 4371.2 4515.3 4518.9 4569.1 4676.9 4705.4 5003.0 5027.6 5037.8 5037.9 5075.5 4760.2 5031.2 5042.2 5048.3 5049.1 4595.2 4626.4 4646.0 4666.3 4702.8 5129.8 5153.1 5157.6 5163.3 5163.7 4959.7 4959.8 4960.4 4994.5 5008.4 4739.1 4858.1 4858.4 4861.6 4971.1 4993.4 5008.9 5009.8 5019.2 5059.7 4972.9 4980.6 4983.5 4986.2 5029.1 3992.7 4048.9 4089.3 4090.4 4098.3 3596.6 3621.6 3669.0 3681.0 3706.4 4264.5 4265.5 4284.0 4293.1 4321.0 4982.3 4987.4 4991.6 4993.6 5037.8 4138.2 4224.9 4239.5 4244.3 4326.5 4464.9 4482.9 4488.6 4489.1 4528.5 4800.3 4802.4 4805.5 4807.9 4846.4 4797.7 4815.8 4904.0 4909.8 4912.4 4771.1 4793.6 4798.2 4798.7 4803.1 4980.9 4982.4 4987.1 4993.0 5021.4 4709.2 4879.2 4881.0 5044.6 5093.4 4802.5 4810.4 4832.1 4919.1 4932.1 4916.5 4935.1 4937.8 4945.1 4986.4 4594.2 4819.7 4843.5 4845.5 4847.3 4736.9 4737.3 4758.4 4828.8 4849.7 4755.5 4792.6 4821.6 4822.9 4863.4 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40345.43 Median:29896.06 stddev:63172.34 (211.3%) stddev-sans-first:63278.94 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: Values: 562.6 565.1 566.8 574.5 576.2 28245.3 28994.0 37060.6 37784.8 37865.2 40962.6 41010.8 41260.6 41314.0 41391.6 7011.5 7147.2 7839.5 8001.3 8001.8 10220.3 10466.8 10470.8 10476.9 10480.7 10035.3 10117.1 10118.1 10124.1 10129.1 7210.0 7399.4 7406.3 7410.4 10060.6 10235.0 10484.6 10485.2 10501.4 10501.6 37501.6 37869.6 38089.0 38091.6 38094.0 2900.3 2905.9 2953.2 3518.0 3602.2 28553.0 28573.7 28832.3 29252.4 29505.3 3433.2 3450.8 3464.8 3506.8 3588.4 225446.0 225845.0 226890.0 227610.0 227918.0 51550.0 52447.7 52537.0 55480.7 55852.4 47187.3 47304.3 66038.7 68216.0 68288.7 13440.9 13561.3 13600.9 13604.3 13671.2 9914.0 10011.3 10045.7 10057.0 10059.2 19082.2 19168.6 19211.4 19237.3 19269.6 7277.2 7507.3 7610.6 7646.4 7736.2 835.5 860.8 890.8 919.2 1030.1 26379.5 26505.3 26688.0 26784.5 26964.9 934.8 948.8 976.9 988.1 996.6 13700.8 13784.2 14138.4 14140.3 14163.6 273513.0 278823.0 279265.0 279849.0 280596.0 45791.8 46121.3 46152.0 46157.0 46159.3 1226.2 1228.0 1234.4 1237.6 1243.3 23399.8 24991.3 25934.6 26458.5 26582.0 38919.6 39264.2 39281.8 39341.4 39424.8 215149.0 217474.0 219053.0 220056.0 220621.0 24867.6 25329.2 27561.6 29154.9 30437.4 37546.0 37847.8 37913.8 38356.8 38468.0 32165.2 32691.0 32743.2 33304.0 33507.7 27151.5 29482.6 32379.8 33016.0 33178.0 32762.5 32850.8 33186.5 33196.2 33276.2 27476.7 29663.9 29825.6 29870.3 29921.9 22818.0 23143.4 23580.8 23609.9 23633.8 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,698 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26049.22 Median:4116.21 stddev:83677.22 (2032.9%) stddev-sans-first:83889.67 16:18:03 INFO - 2015-11-20 16:18:03,699 DEBUG : BROWSER_OUTPUT: Values: 331.5 334.4 335.4 335.4 337.2 12450.8 12721.2 14792.3 15151.6 15766.6 9700.4 9796.4 10024.8 10071.2 10122.5 4523.3 4651.1 4651.2 4651.2 4654.6 3386.4 3491.9 5173.8 5355.5 5360.0 5287.0 5321.4 5324.7 5325.2 5340.4 5243.6 5370.7 5402.8 5404.5 5406.1 5105.5 5202.2 5206.0 5219.9 5221.0 18133.9 18285.7 18598.6 18622.2 18783.7 1754.7 1819.7 1819.8 1822.3 1885.9 8976.2 9146.0 9267.0 11233.3 12498.1 1669.4 1672.9 1715.1 1718.1 1778.0 46290.5 47459.0 50029.2 51745.5 53159.7 9296.0 9525.4 9535.5 9645.1 9718.8 12199.3 12214.8 12220.8 12227.4 12236.7 6727.6 6736.2 6789.1 6810.8 6836.1 6243.1 6262.0 6287.9 6304.4 6407.4 4051.5 4110.8 4121.7 4138.9 4141.5 1562.3 1626.3 1636.7 1699.6 1701.6 372.3 846.6 928.9 977.0 987.1 8939.4 9267.9 9559.0 9829.0 9863.3 354.3 406.9 407.3 414.5 428.8 5342.7 5655.8 5682.1 5724.6 5726.3 497252.0 506215.0 513517.0 519613.0 526209.0 67853.0 68943.0 70094.3 70393.6 70638.3 1067.0 1078.7 1108.1 1144.2 1144.7 14119.6 14459.5 14485.5 14508.4 14523.6 22059.7 24340.6 28633.3 29125.7 29812.6 38986.2 39358.4 39410.4 39790.0 41503.0 8467.5 8657.7 8682.3 8828.0 8883.0 15682.0 15737.9 15777.9 15995.3 16035.4 12946.4 13203.3 13300.0 13376.0 13475.9 11955.9 12167.6 12597.9 12609.4 12719.6 12749.2 13033.3 13327.5 13453.3 13559.1 8740.7 8766.6 8778.1 8839.0 8845.6 9268.4 12957.9 13689.6 13869.7 14330.4 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4660.21 Median:5675.03 stddev:2317.16 (40.8%) stddev-sans-first:2311.09 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: Values: 1449.1 1623.2 1669.9 1694.9 1699.1 5656.7 6528.5 6683.4 6684.1 6685.8 6526.2 6609.5 6617.4 6623.7 6632.3 2001.8 2021.6 2021.8 2023.8 2025.2 2033.8 2040.4 2042.4 2070.0 2077.5 2022.1 2044.5 2045.5 2058.8 2059.4 2001.8 2007.3 2010.8 2012.0 2014.4 2029.7 2041.5 2071.9 2073.7 2079.3 5584.1 5759.7 6544.3 6555.7 6579.5 3874.4 3964.6 3967.7 3986.7 3996.3 2607.5 2629.2 2652.7 2659.5 2759.5 892.6 895.5 902.6 921.6 925.6 8839.0 8907.8 8925.0 8925.1 8941.2 3792.1 3805.5 3842.7 3847.2 3850.6 7757.5 7775.8 7778.6 7780.5 7780.5 4051.0 4051.7 4054.4 4056.3 4057.0 3686.1 3688.3 3689.5 3690.5 3695.8 3238.4 3245.1 3250.0 3252.1 3280.4 1072.8 1084.2 1099.8 1110.6 1111.2 900.5 980.6 1150.5 1165.0 1170.5 5971.0 5977.4 6005.9 6066.5 6067.2 999.8 1028.4 1032.1 1038.9 1042.9 4576.4 5033.4 5073.3 5073.4 5078.3 6810.1 7569.2 7838.9 7852.2 7873.2 7670.4 7696.9 7733.2 7737.3 7749.7 6091.3 6360.5 6377.0 6392.5 6401.6 6351.6 6381.3 6384.5 6396.2 6399.6 6984.7 7164.6 7241.5 7249.5 7266.6 7251.2 7408.3 7448.5 7450.3 7457.2 5637.6 5673.6 5676.4 5686.4 5700.7 5813.2 6032.5 6050.5 6056.6 6083.6 5937.5 5952.6 6051.3 6160.0 6191.5 5852.4 5958.2 5968.6 6008.5 6012.6 5850.6 5985.7 6089.7 6152.5 6177.5 5621.1 5651.6 5653.7 5656.0 5656.0 5460.3 5477.1 5490.8 5499.3 5501.4 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4649.28 Median:5150.33 stddev:1351.91 (26.2%) stddev-sans-first:1315.72 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: Values: 301.0 308.1 309.7 309.9 311.2 5100.6 5210.9 5218.6 5285.4 5306.2 5099.4 5115.4 5224.8 5228.9 5234.9 3927.1 4073.1 4073.6 4115.9 4117.7 4036.8 4039.2 4041.2 4043.5 4043.6 4014.9 4087.2 4123.4 4125.6 4131.6 4117.7 4119.3 4125.2 4125.6 4128.8 3651.5 3651.6 3657.8 3662.7 3662.9 4946.6 5101.8 5118.1 5145.3 5155.3 4769.3 4773.1 4780.0 4781.4 4784.1 5350.4 5573.4 5618.0 5626.4 5629.0 3893.6 3896.0 4008.1 4012.2 4020.9 5758.3 5830.8 5841.4 5853.4 5855.4 4128.9 4133.1 4134.5 4135.9 4136.1 4107.6 4188.6 4196.3 4196.9 4198.6 4737.2 4750.3 4750.7 4753.5 4756.4 5561.1 5561.5 5562.6 5564.2 5566.5 1467.0 1483.3 1485.9 1486.0 1487.2 981.2 1018.0 1020.9 1026.3 1043.5 4882.7 4885.2 4890.4 4891.9 4896.8 5766.6 5771.6 5792.0 5794.5 5805.6 4896.3 4901.5 4902.9 4906.2 4909.6 3052.0 3097.9 3118.4 3125.4 3132.5 5532.8 5533.1 5543.7 5544.5 5551.0 5985.2 6010.1 6011.2 6012.1 6013.6 5529.8 5532.3 5536.1 5536.4 5537.3 5690.6 5854.7 5857.9 5858.8 5861.9 5492.3 5610.1 5613.6 5615.7 5617.8 5390.3 5437.6 5523.3 5535.1 5536.4 3989.8 4007.9 4016.5 4017.2 4019.9 5676.9 5818.2 5822.8 5826.1 5828.7 5594.2 5598.3 5602.4 5603.8 5607.7 5590.8 5600.4 5601.7 5604.0 5607.4 5493.0 5494.6 5501.3 5502.2 5508.4 5477.2 5630.5 5669.9 5675.9 5683.3 5522.6 5530.5 5535.2 5538.7 5542.0 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: 16:18:03 INFO - 2015-11-20 16:18:03,700 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12446.83 Median:45764.77 stddev:14273.24 (31.2%) stddev-sans-first:14285.95 16:18:03 INFO - 2015-11-20 16:18:03,701 DEBUG : BROWSER_OUTPUT: Values: 683.4 704.9 734.5 770.9 819.1 11186.7 11355.4 11364.1 11376.3 11378.4 11468.3 11469.4 11474.0 11638.1 11833.3 624.0 630.5 780.0 785.1 797.4 788.7 797.9 802.3 802.5 803.5 823.7 827.2 827.8 828.2 828.2 645.9 652.1 819.7 830.1 831.0 615.7 616.9 618.0 620.3 622.8 10775.0 10822.5 10881.5 10888.0 10952.7 10452.8 11803.8 11909.3 11958.4 12032.1 9286.3 9303.7 9330.7 9345.9 9428.9 3314.6 3317.4 3340.4 3362.7 3374.3 41334.6 41379.8 41820.4 42313.0 42353.6 9444.4 9466.2 9480.6 9489.0 9508.5 16466.7 16621.3 16628.3 16657.0 16682.3 6355.0 6427.4 6437.2 6437.9 6670.9 3633.7 3653.7 3675.6 3680.7 3763.2 2673.1 2675.1 2701.2 2705.1 2707.1 476.2 482.5 483.0 485.1 489.1 477.7 524.9 613.9 630.5 637.5 7739.8 7889.1 7936.3 8408.4 8546.6 501.5 594.7 599.9 605.8 606.4 3783.3 3838.8 3852.1 3901.2 3936.8 48499.8 49899.3 54232.0 54831.0 55289.0 44281.8 45295.8 45568.3 45721.0 45808.5 41805.2 42103.8 42700.0 42794.1 42813.4 8053.8 8434.4 8451.7 8498.9 8512.7 31534.8 31679.4 31970.7 32441.8 33126.8 36635.0 37120.8 39465.0 41149.8 41171.6 9356.9 10217.9 10308.3 10394.8 10404.3 10515.8 10715.9 10874.3 11059.3 11148.4 10968.0 10983.3 10992.7 11034.3 11065.3 10271.5 10380.6 10650.8 10766.4 10772.5 9883.1 9906.9 10238.6 10573.4 10968.2 9052.5 9252.7 9296.3 9430.7 9451.8 8741.1 8795.0 8820.4 9132.0 9473.9 16:18:03 INFO - 2015-11-20 16:18:03,701 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:18:03 INFO - 2015-11-20 16:18:03,701 DEBUG : BROWSER_OUTPUT: 16:18:04 INFO - 2015-11-20 16:18:04,346 INFO : Browser exited with error code: 0 16:18:04 INFO - 2015-11-20 16:18:04,369 INFO : Completed test dromaeo_css (00:18:38) 16:18:04 INFO - 2015-11-20 16:18:04,369 INFO : Starting test kraken 16:18:04 INFO - 2015-11-20 16:18:04,369 DEBUG : operating with platform_type : linux_ 16:18:04 INFO - 2015-11-20 16:18:04,369 INFO : Initialising browser for kraken test... 16:18:04 INFO - 2015-11-20 16:18:04,375 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp183GNw/profile http://localhost:52263/getInfo.html 16:18:08 INFO - 2015-11-20 16:18:08,277 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:18:08 INFO - 2015-11-20 16:18:08,277 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:18:08 INFO - 2015-11-20 16:18:08,278 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:18:08 INFO - 2015-11-20 16:18:08,278 DEBUG : BROWSER_OUTPUT: __metrics 16:18:08 INFO - 2015-11-20 16:18:08,387 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:18:09 INFO - 2015-11-20 16:18:09,644 INFO : Browser initialized. 16:18:09 INFO - 2015-11-20 16:18:09,645 INFO : Running cycle 1/1 for kraken test... 16:18:09 INFO - 2015-11-20 16:18:09,645 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmp183GNw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:18:21 INFO - 2015-11-20 16:18:21,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 141926400 16:18:21 INFO - 2015-11-20 16:18:21,598 DEBUG : BROWSER_OUTPUT: 16:18:24 INFO - 2015-11-20 16:18:24,185 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:52263/tests/kraken/driver.html?testName=audio-beat-detection) 16:18:24 INFO - 2015-11-20 16:18:24,770 DEBUG : BROWSER_OUTPUT: RSS: Main: 179572736 16:18:24 INFO - 2015-11-20 16:18:24,771 DEBUG : BROWSER_OUTPUT: 16:18:27 INFO - 2015-11-20 16:18:27,473 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:52263/tests/kraken/driver.html?testName=audio-dft) 16:18:28 INFO - 2015-11-20 16:18:28,046 DEBUG : BROWSER_OUTPUT: RSS: Main: 167747584 16:18:28 INFO - 2015-11-20 16:18:28,046 DEBUG : BROWSER_OUTPUT: 16:18:31 INFO - 2015-11-20 16:18:31,053 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:52263/tests/kraken/driver.html?testName=audio-fft) 16:18:31 INFO - 2015-11-20 16:18:31,619 DEBUG : BROWSER_OUTPUT: RSS: Main: 152756224 16:18:31 INFO - 2015-11-20 16:18:31,619 DEBUG : BROWSER_OUTPUT: 16:18:33 INFO - 2015-11-20 16:18:33,651 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:52263/tests/kraken/driver.html?testName=audio-oscillator) 16:18:34 INFO - 2015-11-20 16:18:34,233 DEBUG : BROWSER_OUTPUT: RSS: Main: 153747456 16:18:34 INFO - 2015-11-20 16:18:34,233 DEBUG : BROWSER_OUTPUT: 16:18:36 INFO - 2015-11-20 16:18:36,446 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:52263/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:18:37 INFO - 2015-11-20 16:18:37,015 DEBUG : BROWSER_OUTPUT: RSS: Main: 157102080 16:18:37 INFO - 2015-11-20 16:18:37,015 DEBUG : BROWSER_OUTPUT: 16:18:39 INFO - 2015-11-20 16:18:39,999 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:52263/tests/kraken/driver.html?testName=imaging-darkroom) 16:18:40 INFO - 2015-11-20 16:18:40,573 DEBUG : BROWSER_OUTPUT: RSS: Main: 155365376 16:18:40 INFO - 2015-11-20 16:18:40,573 DEBUG : BROWSER_OUTPUT: 16:18:44 INFO - 2015-11-20 16:18:44,035 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:52263/tests/kraken/driver.html?testName=imaging-desaturate) 16:18:44 INFO - 2015-11-20 16:18:44,616 DEBUG : BROWSER_OUTPUT: RSS: Main: 158347264 16:18:44 INFO - 2015-11-20 16:18:44,616 DEBUG : BROWSER_OUTPUT: 16:18:47 INFO - 2015-11-20 16:18:47,440 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:52263/tests/kraken/driver.html?testName=json-parse-financial) 16:18:48 INFO - 2015-11-20 16:18:48,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 157937664 16:18:48 INFO - 2015-11-20 16:18:48,022 DEBUG : BROWSER_OUTPUT: 16:18:49 INFO - 2015-11-20 16:18:49,796 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:52263/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:18:50 INFO - 2015-11-20 16:18:50,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 163672064 16:18:50 INFO - 2015-11-20 16:18:50,364 DEBUG : BROWSER_OUTPUT: 16:18:52 INFO - 2015-11-20 16:18:52,234 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:18:52 INFO - 2015-11-20 16:18:52,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 164630528 16:18:52 INFO - 2015-11-20 16:18:52,836 DEBUG : BROWSER_OUTPUT: 16:18:54 INFO - 2015-11-20 16:18:54,913 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:18:55 INFO - 2015-11-20 16:18:55,494 DEBUG : BROWSER_OUTPUT: RSS: Main: 167219200 16:18:55 INFO - 2015-11-20 16:18:55,494 DEBUG : BROWSER_OUTPUT: 16:18:58 INFO - 2015-11-20 16:18:58,041 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:18:58 INFO - 2015-11-20 16:18:58,630 DEBUG : BROWSER_OUTPUT: RSS: Main: 176381952 16:18:58 INFO - 2015-11-20 16:18:58,630 DEBUG : BROWSER_OUTPUT: 16:19:01 INFO - 2015-11-20 16:19:01,217 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:19:01 INFO - 2015-11-20 16:19:01,798 DEBUG : BROWSER_OUTPUT: RSS: Main: 176934912 16:19:01 INFO - 2015-11-20 16:19:01,798 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,552 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:52263/tests/kraken/driver.html?testName=ai-astar) 16:19:03 INFO - 2015-11-20 16:19:03,802 DEBUG : BROWSER_OUTPUT: RSS: Main: 236863488 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:19:03 INFO - 2015-11-20 16:19:03,803 DEBUG : BROWSER_OUTPUT: |0;ai-astar;110;112;107;112;113;112;101;111;115;112 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;158;130;149;171;130;163;155;132;165;129 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |2;audio-dft;163;161;161;162;161;160;164;161;162;161 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |3;audio-fft;73;73;80;88;73;72;75;115;88;73 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;92;91;128;91;91;91;120;92;93;132 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;109;109;110;110;110;109;109;110;109;109 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;146;146;146;146;146;146;147;146;147;147 16:19:03 INFO - 2015-11-20 16:19:03,804 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;95;95;95;95;95;96;95;95;94;95 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;70;69;69;70;70;69;70;78;66;68 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;68;68;68;69;68;69;69;69;69;69 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;81;82;82;82;82;82;82;83;84;84 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;128;130;121;123;128;126;129;139;125;118 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;148;146;145;150;149;145;145;148;143;136 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;68;70;68;68;69;68;68;67;69;70 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:19:03 INFO - 2015-11-20 16:19:03,805 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:19:03 INFO - 2015-11-20 16:19:03,806 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,1000 16:19:03 INFO - 2015-11-20 16:19:03,806 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:19:03 INFO - 2015-11-20 16:19:03,806 DEBUG : BROWSER_OUTPUT: __startTimestamp1448065143801__endTimestamp 16:19:03 INFO - 2015-11-20 16:19:03,806 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:110.50 Median:112.00 stddev:3.92 (3.5%) stddev-sans-first:4.16 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: Values: 110.0 112.0 107.0 112.0 113.0 112.0 101.0 111.0 115.0 112.0 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:148.20 Median:156.50 stddev:16.52 (10.6%) stddev-sans-first:17.14 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: Values: 158.0 130.0 149.0 171.0 130.0 163.0 155.0 132.0 165.0 129.0 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:161.60 Median:161.50 stddev:1.17 (0.7%) stddev-sans-first:1.13 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: Values: 163.0 161.0 161.0 162.0 161.0 160.0 164.0 161.0 162.0 161.0 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:81.00 Median:74.00 stddev:13.45 (18.2%) stddev-sans-first:13.95 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: Values: 73.0 73.0 80.0 88.0 73.0 72.0 75.0 115.0 88.0 73.0 16:19:03 INFO - 2015-11-20 16:19:03,814 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:102.10 Median:91.00 stddev:17.21 (18.9%) stddev-sans-first:17.86 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: Values: 92.0 91.0 128.0 91.0 91.0 91.0 120.0 92.0 93.0 132.0 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:109.40 Median:109.50 stddev:0.52 (0.5%) stddev-sans-first:0.53 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: Values: 109.0 109.0 110.0 110.0 110.0 109.0 109.0 110.0 109.0 109.0 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:146.30 Median:146.00 stddev:0.48 (0.3%) stddev-sans-first:0.50 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: Values: 146.0 146.0 146.0 146.0 146.0 146.0 147.0 146.0 147.0 147.0 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:95.00 Median:95.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: Values: 95.0 95.0 95.0 95.0 95.0 96.0 95.0 95.0 94.0 95.0 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:69.90 Median:70.00 stddev:3.11 (4.4%) stddev-sans-first:3.30 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: Values: 70.0 69.0 69.0 70.0 70.0 69.0 70.0 78.0 66.0 68.0 16:19:03 INFO - 2015-11-20 16:19:03,815 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.60 Median:69.00 stddev:0.52 (0.7%) stddev-sans-first:0.50 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: Values: 68.0 68.0 68.0 69.0 68.0 69.0 69.0 69.0 69.0 69.0 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:82.00 stddev:0.97 (1.2%) stddev-sans-first:0.88 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: Values: 81.0 82.0 82.0 82.0 82.0 82.0 82.0 83.0 84.0 84.0 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.70 Median:128.00 stddev:5.74 (4.5%) stddev-sans-first:6.06 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: Values: 128.0 130.0 121.0 123.0 128.0 126.0 129.0 139.0 125.0 118.0 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.50 Median:147.00 stddev:3.98 (2.7%) stddev-sans-first:4.12 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: Values: 148.0 146.0 145.0 150.0 149.0 145.0 145.0 148.0 143.0 136.0 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.50 Median:68.50 stddev:0.97 (1.4%) stddev-sans-first:1.01 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: Values: 68.0 70.0 68.0 68.0 69.0 68.0 68.0 67.0 69.0 70.0 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:19:03 INFO - 2015-11-20 16:19:03,816 DEBUG : BROWSER_OUTPUT: 16:19:04 INFO - 2015-11-20 16:19:04,745 INFO : Browser exited with error code: 0 16:19:04 INFO - 2015-11-20 16:19:04,799 INFO : Completed test kraken (00:01:00) 16:19:04 INFO - 2015-11-20 16:19:04,799 INFO : Starting test v8_7 16:19:04 INFO - 2015-11-20 16:19:04,799 DEBUG : operating with platform_type : linux_ 16:19:04 INFO - 2015-11-20 16:19:04,799 INFO : Initialising browser for v8_7 test... 16:19:04 INFO - 2015-11-20 16:19:04,806 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzQS_V/profile http://localhost:52263/getInfo.html 16:19:08 INFO - 2015-11-20 16:19:08,780 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:19:08 INFO - 2015-11-20 16:19:08,780 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:19:08 INFO - 2015-11-20 16:19:08,781 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/697 16:19:08 INFO - 2015-11-20 16:19:08,781 DEBUG : BROWSER_OUTPUT: __metrics 16:19:08 INFO - 2015-11-20 16:19:08,918 DEBUG : BROWSER_OUTPUT: JavaScript error: resource:///modules/WebappManager.jsm, line 48: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 16:19:10 INFO - 2015-11-20 16:19:10,275 INFO : Browser initialized. 16:19:10 INFO - 2015-11-20 16:19:10,276 INFO : Running cycle 1/1 for v8_7 test... 16:19:10 INFO - 2015-11-20 16:19:10,276 DEBUG : command line: /builds/slave/test/build/application/firefox/firefox -profile /tmp/tmpwzQS_V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:19:22 INFO - 2015-11-20 16:19:22,315 DEBUG : BROWSER_OUTPUT: RSS: Main: 141094912 16:19:22 INFO - 2015-11-20 16:19:22,315 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,678 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:52263/tests/v8_7/run.html (next: http://localhost:52263/tests/v8_7/run.html) 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: RSS: Main: 442499072 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |0;Richards;163.50555918901242 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;191.93857965451056 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |2;Encrypt;282.56569652444193 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5030.150753768844 16:19:43 INFO - 2015-11-20 16:19:43,928 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1968.5039370078741 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: |5;Earley;784.9293563579278 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: |6;Boyer;12708.860759493671 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: |7;RegExp;26631.57894736842 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: |8;Splay;615.7635467980296 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4840.579710144928 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: __startTimestamp1448065183927__endTimestamp 16:19:43 INFO - 2015-11-20 16:19:43,929 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,930 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:19:43 INFO - 2015-11-20 16:19:43,931 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:19:43 INFO - 2015-11-20 16:19:43,931 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,931 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:163.51 Median:163.51 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: Values: 163.5 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:191.94 Median:191.94 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: Values: 191.9 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,932 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:282.57 Median:282.57 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,933 DEBUG : BROWSER_OUTPUT: Values: 282.6 16:19:43 INFO - 2015-11-20 16:19:43,933 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,933 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5030.15 Median:5030.15 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,933 DEBUG : BROWSER_OUTPUT: Values: 5030.2 16:19:43 INFO - 2015-11-20 16:19:43,933 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1968.50 Median:1968.50 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: Values: 1968.5 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:784.93 Median:784.93 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: Values: 784.9 16:19:43 INFO - 2015-11-20 16:19:43,934 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12708.86 Median:12708.86 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: Values: 12708.9 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26631.58 Median:26631.58 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: Values: 26631.6 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:615.76 Median:615.76 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,935 DEBUG : BROWSER_OUTPUT: Values: 615.8 16:19:43 INFO - 2015-11-20 16:19:43,936 DEBUG : BROWSER_OUTPUT: 16:19:43 INFO - 2015-11-20 16:19:43,936 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4840.58 Median:4840.58 stddev:0.00 (0.0%) 16:19:43 INFO - 2015-11-20 16:19:43,936 DEBUG : BROWSER_OUTPUT: Values: 4840.6 16:19:43 INFO - 2015-11-20 16:19:43,936 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:19:43 INFO - 2015-11-20 16:19:43,936 DEBUG : BROWSER_OUTPUT: 16:19:44 INFO - 2015-11-20 16:19:44,865 INFO : Browser exited with error code: 0 16:19:44 INFO - 2015-11-20 16:19:44,880 INFO : Completed test v8_7 (00:00:40) 16:19:44 INFO - 2015-11-20 16:19:44,986 INFO : Completed test suite (00:20:18) 16:19:44 INFO - 2015-11-20 16:19:44,986 DEBUG : Working with test: dromaeo_css 16:19:44 INFO - 2015-11-20 16:19:44,986 DEBUG : Generating results file: dromaeo_css 16:19:44 INFO - 2015-11-20 16:19:44,987 DEBUG : Working with test: kraken 16:19:44 INFO - 2015-11-20 16:19:44,988 DEBUG : Generating results file: kraken 16:19:44 INFO - 2015-11-20 16:19:44,988 INFO : javascript benchmark 16:19:44 INFO - 2015-11-20 16:19:44,988 DEBUG : Working with test: v8_7 16:19:44 INFO - 2015-11-20 16:19:44,988 DEBUG : Generating results file: v8_7 16:19:44 INFO - 2015-11-20 16:19:44,988 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:45 INFO - 2015-11-20 16:19:45,034 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,94,35]] 16:19:45 INFO - 2015-11-20 16:19:45,034 DEBUG : process_Request line: dromaeo_css 6192.25 graph.html#tests=[[72,94,35]] 16:19:45 INFO - 2015-11-20 16:19:45,034 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:45 INFO - 2015-11-20 16:19:45,068 DEBUG : process_Request line: kraken 1515.70 graph.html#tests=[[232,94,35]] 16:19:45 INFO - 2015-11-20 16:19:45,068 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:19:45 INFO - 2015-11-20 16:19:45,092 DEBUG : process_Request line: v8_7 19733.76 graph.html#tests=[[230,94,35]] 16:19:45 INFO - 2015-11-20 16:19:45,093 INFO : javascript benchmark 16:19:45 INFO - 2015-11-20 16:19:45,097 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2657.667791526059, 2728.3588356736163, 2731.3035176030107, 2741.109139529652, 2757.2141939547228, 4464.464264288282, 4607.562281583253, 4620.168369693454, 4625.028743963768, 4638.443386793581, 4567.611753000991, 4571.51999040101, 4590.013147173357, 4662.160811054009, 4667.929981050287, 4250.2137104635585, 4278.657707383401, 4286.078493123978, 4289.528151903296, 4332.0469496710675, 4097.692673049518, 4288.828446862121, 4297.763623000734, 4343.283358245902, 4362.367456718774, 4183.142455796555, 4250.702450828443, 4268.59448352406, 4274.166537525184, 4286.592773686495, 4282.379055037033, 4326.935095973531, 4338.370936214231, 4370.2133615949115, 4373.409589705381, 4066.1867626474527, 4305.117450922553, 4317.395564620955, 4326.480822301312, 4371.191329604034, 4515.254982927813, 4518.932216016762, 4569.1318649456825, 4676.859694209179, 4705.411823522059, 5003.049420610072, 5027.622928280357, 5037.823676171316, 5037.949620503821, 5075.5178258065425, 4760.214564596838, 5031.1950087986115, 5042.168042273021, 5048.318477005594, 5049.116404629175, 4595.218812801765, 4626.398568186148, 4645.976770116128, 4666.300054991711, 4702.788374523155, 5129.769160387791, 5153.072446959583, 5157.63896527247, 5163.277141200235, 5163.66436181647, 4959.70241785494, 4959.801607935714, 4960.355153829979, 4994.500549944976, 5008.398992120896, 4739.099571081552, 4858.149823780895, 4858.368412106403, 4861.586765124934, 4971.055499455092, 4993.375828021497, 5008.899822003539, 5009.774560144802, 5019.196928491424, 5059.696418214919, 4972.925406118911, 4980.576650984707, 4983.451820299764, 4986.202207646832, 5029.06962211992, 3992.7005474589523, 4048.8987775305854, 4089.3252613319064, 4090.447789548373, 4098.344264917599, 3596.5684117906017, 3621.5654121505063, 3668.963310366862, 3681.042928838521, 3706.3513885070543, 4264.530901600821, 4265.50946641134, 4283.957160428418, 4293.141371725667, 4321.027768752006, 4982.252662100642, 4987.376577927759, 4991.575716064175, 4993.6005119590345, 5037.848864534069, 4138.213739389506, 4224.852130175429, 4239.491261048694, 4244.257254980366, 4326.459192600925, 4464.888377790581, 4482.8655140345845, 4488.5960263576435, 4489.079738653568, 4528.45658520973, 4800.279958006327, 4802.351682522954, 4805.471398146131, 4807.855764327076, 4846.442659094178, 4797.712137271775, 4815.759212039454, 4903.975480122719, 4909.803607855646, 4912.435069966999, 4771.093492236464, 4793.640476964172, 4798.160321943716, 4798.712077275374, 4803.063402636452, 4980.900381992267, 4982.402111746614, 4987.0524600325825, 4993.0, 5021.447640759587, 4709.222978208557, 4879.170541007966, 4881.0, 5044.571211446922, 5093.414257360303, 4802.51974802517, 4810.374651295309, 4832.106060378841, 4919.114559379203, 4932.1122198004705, 4916.483769204182, 4935.136351138608, 4937.802487900443, 4945.060438516671, 4986.376702912136, 4594.2419500782, 4819.6867203631655, 4843.539863712942, 4845.466998630219, 4847.297141914332, 4736.8578942631775, 4737.265723812815, 4758.405199350082, 4828.782704778223, 4849.709017458823, 4755.524447555217, 4792.616590672668, 4821.566059054702, 4822.903541929071, 4863.367762190893], "unit": "ms", "name": "dojo.html", "value": 4574.278828879413}, {"lowerIsBetter": false, "replicates": [562.5640128900102, 565.1043096691743, 566.7591273708673, 574.5030548575484, 576.2479963647442, 28245.293867653294, 28994.0, 37060.62939370609, 37784.81107594465, 37865.24269514608, 40962.59037409625, 41010.7949460253, 41260.58739412605, 41314.0, 41391.58608413915, 7011.544249623758, 7147.2138064812825, 7839.451238413313, 8001.319887809544, 8001.799955001114, 10220.284580079397, 10466.842997355046, 10470.842937355947, 10476.947615261914, 10480.737981550485, 10035.29752917296, 10117.14004309631, 10118.089371956523, 10124.088832005118, 10129.088382045615, 7210.0, 7399.408047356253, 7406.296401841816, 7410.407167426647, 10060.597576096947, 10235.0, 10484.58061677532, 10485.21360897928, 10501.4224217668, 10501.579936802518, 37501.62498375036, 37869.621303787164, 38089.0, 38091.619083809084, 38094.0, 2900.274931267183, 2905.941881162386, 2953.1731115287753, 3517.9648203517895, 3602.189507360849, 28553.0, 28573.714262857313, 28832.279193020342, 29252.41495170106, 29505.262368440744, 3433.1931995980926, 3450.8102054387, 3464.7747896386654, 3506.8421921013614, 3588.3899737044767, 225446.0, 225845.0, 226890.0, 227610.0, 227918.0, 51550.0, 52447.73776131095, 52537.0, 55480.72259638676, 55852.44147558554, 47187.34844280434, 47304.290435643496, 66038.66980665067, 68216.0, 68288.6585567069, 13440.865591344156, 13561.321933903266, 13600.93199533996, 13604.251766152758, 13671.248081355421, 9914.0, 10011.349262297927, 10045.69862904114, 10057.044580764816, 10059.245556583286, 19082.236710531703, 19168.61662766737, 19211.423657290303, 19237.326693565938, 19269.61460770805, 7277.19950805411, 7507.324340809353, 7610.581418021951, 7646.4265180111715, 7736.187700291501, 835.4569529805675, 860.7848037990502, 890.808476177612, 919.1589695428742, 1030.1295405382439, 26379.472410552065, 26505.33736656599, 26688.0, 26784.464310713676, 26964.865175673996, 934.7709811096325, 948.8102379524123, 976.9462679552693, 988.1403179233969, 996.5515518016921, 13700.794488082687, 13784.241866697228, 14138.363773630212, 14140.292985350692, 14163.64590885236, 273513.0, 278823.0, 279265.0, 279849.0, 280596.0, 45791.77104114458, 46121.308180377324, 46152.0, 46157.0, 46159.30761038587, 1226.1845872494869, 1227.969300767488, 1234.3766397969148, 1237.55448038706, 1243.2726854790048, 23399.76600234044, 24991.250262492154, 25934.610980834925, 26458.470830583665, 26582.0, 38919.610803892734, 39264.2147157061, 39281.803590981865, 39341.40987885241, 39424.802875985435, 215149.0, 217474.0, 219053.0, 220056.0, 220621.0, 24867.62698559559, 25329.240122796346, 27561.58657620097, 29154.854225728737, 30437.391252175275, 37546.0, 37847.81076094602, 37913.810430948775, 38356.80821595874, 38468.0, 32165.195870103435, 32691.0, 32743.18142046468, 33304.0, 33507.66492335143, 27151.45697086087, 29482.557761634023, 32379.838100810288, 33016.0, 33178.0, 32762.50856237206, 32850.83574582112, 33186.50220246746, 33196.174210417696, 33276.1680957978, 27476.725232747416, 29663.85168074146, 29825.552616710334, 29870.25324366908, 29921.873828482523, 22818.0, 23143.421414464774, 23580.764192357856, 23609.93755280982, 23633.763662363155], "unit": "ms", "name": "ext.html", "value": 17111.92801057944}, {"lowerIsBetter": false, "replicates": [331.49281599153306, 334.4080976671292, 335.35611625678695, 335.3862431749898, 337.2142907026628, 12450.750984980317, 12721.17312374695, 14792.260386980663, 15151.621209469755, 15766.605834854148, 9700.369475984056, 9796.412215267072, 10024.799504009916, 10071.244656650762, 10122.493875306242, 4523.276275795865, 4651.093036857814, 4651.186042442576, 4651.232546629819, 4654.557817007379, 3386.4412371958597, 3491.8952431427097, 5173.818916337929, 5355.544778693797, 5360.035193665139, 5287.048331300364, 5321.361436627591, 5324.7071411072375, 5325.201219817039, 5340.439253878345, 5243.580513558906, 5370.731463426852, 5402.837914862561, 5404.486573775524, 5406.135018397057, 5105.463926287761, 5202.167653175474, 5206.0, 5219.921701174486, 5221.0, 18133.909330453396, 18285.725714114298, 18598.62802743951, 18622.16200270991, 18783.718244226347, 1754.6929287374658, 1819.6542656895147, 1819.7543331650322, 1822.280199321274, 1885.9151338189815, 8976.192142707123, 9145.954270228607, 9267.0, 11233.32600044, 12498.062645301548, 1669.4323929863904, 1672.874534409912, 1715.0995727243173, 1718.1021426620725, 1778.0487439220085, 46290.5370946293, 47459.0, 50029.24956125661, 51745.48254517482, 53159.734201329135, 9295.953520232355, 9525.428474291564, 9535.52322383892, 9645.131938125462, 9718.805623887483, 12199.329036903055, 12214.816777748341, 12220.75558488843, 12227.388630568435, 12236.694082647828, 6727.562708424035, 6736.1916570010935, 6789.083473730983, 6810.795676129724, 6836.111305530249, 6243.125962365272, 6262.0, 6287.937120628827, 6304.369563043659, 6407.391297826699, 4051.534073581517, 4110.753354798721, 4121.670266378683, 4138.937915931264, 4141.503019637663, 1562.2579274844586, 1626.3413317606153, 1636.6972110159659, 1699.6430749542735, 1701.5575950253024, 372.2907860525703, 846.5597889097635, 928.8699582058517, 977.0327375897951, 987.110783512971, 8939.374243802871, 9267.907320926704, 9558.952205239068, 9828.950855245821, 9863.260255480867, 354.2507596433576, 406.92471892699945, 407.3279089502345, 414.5460720511036, 428.83061190830074, 5342.732863356817, 5655.773769049192, 5682.119271512922, 5724.570657200727, 5726.312842458931, 497252.0, 506215.0, 513517.0, 519613.0, 526209.0, 67853.0, 68943.0, 70094.29905700877, 70393.64803175951, 70638.29361706317, 1067.0449947297125, 1078.7087486378791, 1108.130117857478, 1144.2219290882113, 1144.719543711796, 14119.64700882486, 14459.493917712829, 14485.493007744679, 14508.429542311313, 14523.636909077357, 22059.66910496376, 24340.634890476304, 28633.28416789597, 29125.7087429123, 29812.552811707406, 38986.22027559376, 39358.409623856234, 39410.40884386679, 39790.0, 41503.0, 8467.49195048299, 8657.696980605648, 8682.262007729161, 8827.955860220658, 8883.0, 15682.0, 15737.921310393374, 15777.921110394374, 15995.280212390238, 16035.438759643357, 12946.352682365656, 13203.273819939996, 13300.0, 13376.0, 13475.865241347461, 11955.880441195477, 12167.634970950885, 12597.937010315256, 12609.43257553394, 12719.55481558141, 12749.17130386522, 13033.283169425773, 13327.466901323838, 13453.260070695815, 13559.118657287245, 8740.650373984969, 8766.605502752263, 8778.078301778221, 8839.027706952358, 8845.646174152962, 9268.443893366419, 12957.870421295667, 13689.589312320646, 13869.653258668613, 14330.355134019203], "unit": "ms", "name": "jquery.html", "value": 7608.411334548186}, {"lowerIsBetter": false, "replicates": [1449.058112227053, 1623.2451909861911, 1669.8998060116394, 1694.8898321609101, 1699.0570233520396, 5656.745446454909, 6528.4777217822575, 6683.398494135533, 6684.064231007651, 6685.765998190064, 6526.216853977529, 6609.504287178457, 6617.437517810992, 6623.735050597982, 6632.336766323365, 2001.8498612604076, 2021.6361055010093, 2021.7674967378719, 2023.8380929525676, 2025.1696804310236, 2033.8372930165626, 2040.3776848061336, 2042.428120126367, 2069.9793002069937, 2077.511784730587, 2022.100165426386, 2044.5195379085978, 2045.509077821327, 2058.763242227148, 2059.3513043391285, 2001.7798042215345, 2007.2673474181966, 2010.829079528242, 2012.0442789674933, 2014.446027342478, 2029.7056926745686, 2041.5202427429542, 2071.8860462674547, 2073.7200477935435, 2079.2618620389694, 5584.106542953149, 5759.68321742304, 6544.280129185786, 6555.737770489175, 6579.539432239745, 3874.438206460076, 3964.5837187095517, 3967.682585393162, 3986.7009974252046, 3996.3406038003695, 2607.478504299129, 2629.1718108795667, 2652.7082020977678, 2659.4548117635836, 2759.4756996170863, 892.5938697892443, 895.4627223665749, 902.566767951387, 921.5530467723149, 925.5834874306522, 8839.0, 8907.821843563157, 8924.955375223148, 8925.107489251088, 8941.150590693938, 3792.1467669774634, 3805.486259355007, 3842.6742773743013, 3847.153626202231, 3850.5956874528333, 7757.534547927143, 7775.805604859811, 7778.572178530122, 7780.533168009937, 7780.533168009937, 4051.0, 4051.736637118578, 4054.412110244057, 4056.290149223933, 4056.9797151014645, 3686.1153323202775, 3688.280785246851, 3689.5019172411917, 3690.5202323698286, 3695.796731179757, 3238.3847069056806, 3245.1075954112807, 3249.9837500812346, 3252.10567094051, 3280.425925463034, 1072.8337107748312, 1084.203110713625, 1099.8020356335776, 1110.5724296145881, 1111.2110401614782, 900.5407242306339, 980.5734505490135, 1150.5225331487507, 1165.0155618502522, 1170.5083864776814, 5971.0, 5977.372375900555, 6005.909911351333, 6066.514678825683, 6067.150598916155, 999.7550600103021, 1028.4446398944635, 1032.055669062814, 1038.9116925061455, 1042.8696412948382, 4576.382188404589, 5033.395992480926, 5073.340465739504, 5073.365829271341, 5078.289039534468, 6810.080639113756, 7569.167391586921, 7838.941742864754, 7852.154743635241, 7873.212678732081, 7670.386369090459, 7696.884546731803, 7733.188015258429, 7737.342325902248, 7749.651265693057, 6091.329953705089, 6360.491160707133, 6376.968115159394, 6392.488600912009, 6401.615903045832, 6351.555391122577, 6381.266154392304, 6384.521160912857, 6396.200474940632, 6399.55203135776, 6984.650767461708, 7164.641767911688, 7241.493095483265, 7249.492535522463, 7266.600336981517, 7251.23861994483, 7408.296211859864, 7448.5158464699625, 7450.254974502506, 7457.179710231979, 5637.577181711306, 5673.631213971079, 5676.4323567642905, 5686.43135686428, 5700.686462244616, 5813.215215945793, 6032.517398608188, 6050.485708714808, 6056.636601803906, 6083.574149809471, 5937.495312898279, 5952.642841429528, 6051.273847138195, 6160.0, 6191.473724733448, 5852.385499522659, 5958.1658567801405, 5968.612040217372, 6008.519318454601, 6012.579119461596, 5850.64896106235, 5985.700714964321, 6089.725962331794, 6152.50779937595, 6177.505799536116, 5621.128725047624, 5651.632643878134, 5653.745581448927, 5656.010198215378, 5656.038473459604, 5460.34475862899, 5477.096279113902, 5490.80782172622, 5499.2576002240785, 5501.449855014466], "unit": "ms", "name": "mootools.html", "value": 3903.223567655231}, {"lowerIsBetter": false, "replicates": [300.98645560949757, 308.0650226562382, 309.66092129118624, 309.91477343730486, 311.22349737405176, 5100.591952643789, 5210.869728256791, 5218.5564227040695, 5285.365756109262, 5306.230596563496, 5099.413567439746, 5115.360579927509, 5224.764885580148, 5228.92156617651, 5234.947650523493, 3927.0771368728324, 4073.083556199846, 4073.5926407359325, 4115.8971025724295, 4117.69117316201, 4036.8385264589383, 4039.212353591051, 4041.1513582147636, 4043.4541336919433, 4043.575424580421, 4014.899627509321, 4087.2438598859308, 4123.443335149746, 4125.587441255881, 4131.607497287753, 4117.69117316201, 4119.299719047769, 4125.154343359619, 4125.5874412558505, 4128.772917489537, 3651.543557055368, 3651.561812582507, 3657.7622454540638, 3662.6703596676425, 3662.853485860562, 4946.554810067075, 5101.846944591631, 5118.104331741967, 5145.331106956071, 5155.329807125087, 4769.308450274725, 4773.140834649762, 4780.043991201774, 4781.426228852525, 4784.067106914154, 5350.438203988564, 5573.359063707685, 5618.0, 5626.437356264381, 5629.043062679354, 3893.5911729268587, 3895.9805200973815, 4008.118213992946, 4012.197560487914, 4020.9396859047138, 5758.3090029196765, 5830.7959221427045, 5841.386654401269, 5853.443922827325, 5855.385184555603, 4128.855490057834, 4133.132042271157, 4134.524529679065, 4135.875923722293, 4136.131412403369, 4107.609777071173, 4188.623023927861, 4196.328587425997, 4196.874093777192, 4198.5591512891315, 4737.218358970731, 4750.311204875343, 4750.714957102585, 4753.500882407367, 4756.405449318835, 5561.138023606267, 5561.5272701820795, 5562.582806289544, 5564.165375193672, 5566.526845218202, 1467.0, 1483.2954346685237, 1485.89598728088, 1486.0, 1487.152323175801, 981.2297346582898, 1018.022698209727, 1020.9030142136485, 1026.3328836256494, 1043.5251960358019, 4882.6826256293225, 4885.2427873679635, 4890.364252647204, 4891.853244402673, 4896.828610998669, 5766.567507436959, 5771.567132465082, 5792.044312688444, 5794.5364370851075, 5805.622634528742, 4896.290037944478, 4901.485344038824, 4902.852914412502, 4906.165951788204, 4909.631777616693, 3051.969480305213, 3097.90706278812, 3118.4075025745037, 3125.390548842999, 3132.4674805283157, 5532.75102620375, 5533.114701647717, 5543.722813859291, 5544.528715059185, 5550.972245138829, 5985.22192115031, 6010.128531363015, 6011.158437818709, 6012.128241404972, 6013.609115407485, 5529.806456773994, 5532.336119665666, 5536.141898005815, 5536.446355364431, 5537.335519737577, 5690.573207009408, 5854.677992710442, 5857.882842343214, 5858.794942177004, 5861.912071319019, 5492.258545096361, 5610.102383618601, 5613.607047506635, 5615.6630602164005, 5617.8033768817895, 5390.272313237662, 5437.592180586551, 5523.337199536081, 5535.0590399632965, 5536.4186760389575, 3989.8005099744314, 4007.859724909614, 4016.5380981187536, 4017.216642754635, 4019.919601607893, 5676.943230567642, 5818.156367326629, 5822.7670893163795, 5826.126081087701, 5828.737706803119, 5594.188842617879, 5598.300212473441, 5602.3837377887585, 5603.831885043455, 5607.747651355618, 5590.776368945197, 5600.383957764724, 5601.663900166003, 5604.047311957059, 5607.383187849415, 5492.972535137299, 5494.560435165097, 5501.339839219159, 5502.202180683858, 5508.366537848199, 5477.233187353694, 5630.465105814941, 5669.922714684197, 5675.858103547444, 5683.318001839641, 5522.6134170607675, 5530.5022547970875, 5535.169724541351, 5538.667679939216, 5542.0], "unit": "ms", "name": "prototype.html", "value": 4219.381298861037}, {"lowerIsBetter": false, "replicates": [683.3542302524114, 704.9295070492951, 734.5262305812751, 770.8689522781127, 819.1112642782581, 11186.720331991693, 11355.432228388569, 11364.147688923344, 11376.317420954749, 11378.431078446076, 11468.311901285908, 11469.369184694839, 11474.024707899818, 11638.127140464456, 11833.349165795878, 623.9906401403982, 630.5271046714964, 779.9844003119935, 785.077533897668, 797.4497596658316, 788.7160622176012, 797.9401544884128, 802.2859654907137, 802.5064585280069, 803.461680673947, 823.7405217356544, 827.1934863508092, 827.7516744976483, 828.1883753921161, 828.2421584250434, 645.8514541655422, 652.1098700274115, 819.692615269277, 830.0993422136988, 831.0193971114084, 615.7260019291417, 616.8951278282658, 618.0296933813914, 620.3145524195744, 622.7975907829973, 10775.0, 10822.512986915608, 10881.455927203608, 10888.0, 10952.671419857417, 10452.843207351896, 11803.822942655866, 11909.285442873368, 11958.40207989597, 12032.097592680497, 9286.257099432029, 9303.72088837336, 9330.67342643011, 9345.906540934571, 9428.90571094294, 3314.552535407713, 3317.402867483852, 3340.3987282289177, 3362.697357237836, 3374.308266805299, 41334.58665413367, 41379.7931010346, 41820.372694409605, 42313.0, 42353.57646423527, 9444.386114902509, 9466.242700583936, 9480.573374198178, 9488.95255523718, 9508.477033763209, 16466.6706665866, 16621.252043658063, 16628.33486660544, 16657.0, 16682.332706691595, 6355.046742988588, 6427.357264273535, 6437.227532696106, 6437.871242575122, 6670.866582668319, 3633.7274704397278, 3653.7442379033746, 3675.61406052366, 3680.723945704083, 3763.1532905096683, 2673.0777881630806, 2675.1305825606755, 2701.2031450722084, 2705.1208357283963, 2707.0931238035087, 476.1738383903924, 482.4765129834099, 482.99054975102206, 485.09045539613226, 489.1317910708521, 477.6560876169222, 524.8687828042989, 613.9140520327069, 630.486153784664, 637.512303088138, 7739.845203095907, 7889.09275433321, 7936.2857342839425, 8408.41141120128, 8546.572671366406, 501.4859768737074, 594.7234535940809, 599.8890205312031, 605.8485378655337, 606.3542327421283, 3783.281176576442, 3838.808059597065, 3852.1332700142802, 3901.200253947934, 3936.7637941723588, 48499.75750121227, 49899.25151122736, 54232.0, 54831.0, 55289.0, 44281.778591106835, 45295.77352113284, 45568.3164752529, 45721.0, 45808.541914580426, 41805.1638967219, 42103.842211834235, 42700.0, 42794.14411711811, 42813.35779963303, 8053.758387248392, 8434.390043149824, 8451.704190353308, 8498.872516912128, 8512.659493620433, 31534.842325788224, 31679.36641267208, 31970.6802931977, 32441.837790810896, 33126.834365828014, 36635.0, 37120.814395927846, 39465.0, 41149.79425102855, 41171.58828411797, 9356.906430935876, 10217.897821021694, 10308.278420510493, 10394.792104158027, 10404.271700980858, 10515.842262365917, 10715.935793808827, 10874.293170943864, 11059.281146725438, 11148.386838723623, 10968.0, 10983.340999540053, 10992.670219893416, 11034.337939723642, 11065.336079835235, 10271.537780800032, 10380.584776608852, 10650.786984260427, 10766.407847568458, 10772.461376930965, 9883.11052005323, 9906.900930990598, 10238.590456381662, 10573.418461984666, 10968.17738669587, 9052.463138644333, 9252.676156334495, 9296.280989677916, 9430.669926552811, 9451.78639262654, 8741.125887411463, 8794.956025219833, 8820.382573219813, 9131.990961988351, 9473.905260947578], "unit": "ms", "name": "yui.html", "value": 5747.2438525420375}], "name": "dromaeo_css", "value": 6192.256737655266}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 112.0, 107.0, 112.0, 113.0, 112.0, 101.0, 111.0, 115.0, 112.0], "unit": "ms", "name": "ai-astar", "value": 110.5}, {"lowerIsBetter": true, "replicates": [158.0, 130.0, 149.0, 171.0, 130.0, 163.0, 155.0, 132.0, 165.0, 129.0], "unit": "ms", "name": "audio-beat-detection", "value": 148.2}, {"lowerIsBetter": true, "replicates": [163.0, 161.0, 161.0, 162.0, 161.0, 160.0, 164.0, 161.0, 162.0, 161.0], "unit": "ms", "name": "audio-dft", "value": 161.6}, {"lowerIsBetter": true, "replicates": [73.0, 73.0, 80.0, 88.0, 73.0, 72.0, 75.0, 115.0, 88.0, 73.0], "unit": "ms", "name": "audio-fft", "value": 81.0}, {"lowerIsBetter": true, "replicates": [92.0, 91.0, 128.0, 91.0, 91.0, 91.0, 120.0, 92.0, 93.0, 132.0], "unit": "ms", "name": "audio-oscillator", "value": 102.1}, {"lowerIsBetter": true, "replicates": [109.0, 109.0, 110.0, 110.0, 110.0, 109.0, 109.0, 110.0, 109.0, 109.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 109.4}, {"lowerIsBetter": true, "replicates": [146.0, 146.0, 146.0, 146.0, 146.0, 146.0, 147.0, 146.0, 147.0, 147.0], "unit": "ms", "name": "imaging-darkroom", "value": 146.3}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 95.0, 95.0, 95.0, 96.0, 95.0, 95.0, 94.0, 95.0], "unit": "ms", "name": "imaging-desaturate", "value": 95.0}, {"lowerIsBetter": true, "replicates": [70.0, 69.0, 69.0, 70.0, 70.0, 69.0, 70.0, 78.0, 66.0, 68.0], "unit": "ms", "name": "json-parse-financial", "value": 69.9}, {"lowerIsBetter": true, "replicates": [68.0, 68.0, 68.0, 69.0, 68.0, 69.0, 69.0, 69.0, 69.0, 69.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.6}, {"lowerIsBetter": true, "replicates": [81.0, 82.0, 82.0, 82.0, 82.0, 82.0, 82.0, 83.0, 84.0, 84.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 82.4}, {"lowerIsBetter": true, "replicates": [128.0, 130.0, 121.0, 123.0, 128.0, 126.0, 129.0, 139.0, 125.0, 118.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.7}, {"lowerIsBetter": true, "replicates": [148.0, 146.0, 145.0, 150.0, 149.0, 145.0, 145.0, 148.0, 143.0, 136.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 145.5}, {"lowerIsBetter": true, "replicates": [68.0, 70.0, 68.0, 68.0, 69.0, 68.0, 68.0, 67.0, 69.0, 70.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 68.5}], "name": "kraken", "value": 1515.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [163.50555918901242], "unit": "score", "name": "Richards", "value": 215.90703200000004}, {"lowerIsBetter": false, "replicates": [191.93857965451056], "unit": "score", "name": "DeltaBlue", "value": 344.4747799999999}, {"lowerIsBetter": false, "replicates": [282.56569652444193], "unit": "score", "name": "Encrypt", "value": 942.0145590000004}, {"lowerIsBetter": false, "replicates": [5030.150753768844], "unit": "score", "name": "Decrypt", "value": 52.91710189810189}, {"lowerIsBetter": false, "replicates": [1968.5039370078741], "unit": "score", "name": "RayTrace", "value": 375.9144119999999}, {"lowerIsBetter": false, "replicates": [784.9293563579278], "unit": "score", "name": "Earley", "value": 849.0738620000004}, {"lowerIsBetter": false, "replicates": [12708.860759493671], "unit": "score", "name": "Boyer", "value": 52.440813745019945}, {"lowerIsBetter": false, "replicates": [26631.57894736842], "unit": "score", "name": "RegExp", "value": 34.20694664031621}, {"lowerIsBetter": false, "replicates": [615.7635467980296], "unit": "score", "name": "Splay", "value": 132.34138400000003}, {"lowerIsBetter": false, "replicates": [4840.579710144928], "unit": "score", "name": "NavierStokes", "value": 306.5748502994012}], "name": "v8_7", "value": 19733.76453349658}]} 16:19:45 INFO - RETURN: dromaeo_css: 6192.25 16:19:45 INFO - RETURN: kraken: 1515.70 16:19:45 INFO - RETURN: v8_7: 19733.76 16:19:45 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,94,35]]", "result": "19733.76"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,94,35]]", "result": "1515.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,94,35]]", "result": "6192.25"}}} 16:19:45 INFO - Return code: 0 16:19:45 INFO - # TBPL SUCCESS # 16:19:45 INFO - Running post-action listener: _resource_record_post_action 16:19:45 INFO - Running post-run listener: _resource_record_post_run 16:19:46 INFO - Total resource usage - Wall time: 1233s; CPU: 13.0%; Read bytes: 8192; Write bytes: 516235264; Read time: 196; Write time: 500668 16:19:46 INFO - install - Wall time: 14s; CPU: 13.0%; Read bytes: 0; Write bytes: 49008640; Read time: 0; Write time: 18640 16:19:46 INFO - run-tests - Wall time: 1219s; CPU: 13.0%; Read bytes: 4096; Write bytes: 367304704; Read time: 12; Write time: 395920 16:19:46 INFO - Running post-run listener: _upload_blobber_files 16:19:46 INFO - Blob upload gear active. 16:19:46 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:19:46 INFO - Copying logs to upload dir... 16:19:46 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1269.893537 ========= master_lag: 0.07 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2015-11-20 16:19:46.260767) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:19:46.268458) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False build_url:https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/artifacts/public/build/firefox-45.0a1.en-US.linux-x86_64.tar.bz2 program finished with exit code 0 elapsedTime=0.010018 build_url: 'https://queue.taskcluster.net/v1/task/RFQPaL0PRty1QyIZsv7PzQ/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 16:19:46.318998) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:19:46.322439) ========= 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=61fa6ed41387771909ec0f71000001b3-1448063759.661918-219331299 XPCOM_DEBUG_BREAK=warn _=/tools/buildbot/bin/python using PTY: False program finished with exit code 0 elapsedTime=0.004668 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:19:46.371888) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:19:46.372206) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:19:46.372522) ========= ========= Total master_lag: 0.28 =========